builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465507709.96 results: success (0) buildid: 20160609113016 builduid: 8e4747667347419d9e7e78983d3bed2a revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:29.958386) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:29.958805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:29.959082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:29.977321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:29.977649) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:28:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-06-09 14:28:30 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.074825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.075136) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.128117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.129618) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afc529c199066e9c9d8a88318f24f631a7678d53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev afc529c199066e9c9d8a88318f24f631a7678d53 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:28:30,245 truncating revision to first 12 chars 2016-06-09 14:28:30,245 Setting DEBUG logging. 2016-06-09 14:28:30,245 attempt 1/10 2016-06-09 14:28:30,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afc529c19906?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:28:30,581 unpacking tar archive at: fx-team-afc529c19906/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.780453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.780778) ========= script_repo_revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.781157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.781438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:28:30.792662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 14:28:30.793049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:28:30 INFO - MultiFileLogger online at 20160609 14:28:30 in /builds/slave/test 14:28:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:28:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:28:30 INFO - {'append_to_log': False, 14:28:30 INFO - 'base_work_dir': '/builds/slave/test', 14:28:30 INFO - 'blob_upload_branch': 'Fx-Team', 14:28:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:28:30 INFO - 'branch': 'Fx-Team', 14:28:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:28:30 INFO - 'config_files': ('talos/linux_config.py',), 14:28:30 INFO - 'default_actions': ('clobber', 14:28:30 INFO - 'read-buildbot-config', 14:28:30 INFO - 'download-and-extract', 14:28:30 INFO - 'populate-webroot', 14:28:30 INFO - 'create-virtualenv', 14:28:30 INFO - 'install', 14:28:30 INFO - 'run-tests'), 14:28:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:28:30 INFO - 'download_minidump_stackwalk': True, 14:28:30 INFO - 'download_symbols': 'ondemand', 14:28:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:28:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:28:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:28:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:28:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:28:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:28:31 INFO - 'installer_path': 'installer.exe', 14:28:31 INFO - 'log_level': 'info', 14:28:31 INFO - 'log_name': 'talos', 14:28:31 INFO - 'log_to_console': True, 14:28:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:28:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:28:31 INFO - 'opt_config_files': (), 14:28:31 INFO - 'pip_index': False, 14:28:31 INFO - 'sps_profile': False, 14:28:31 INFO - 'sps_profile_interval': 0, 14:28:31 INFO - 'suite': 'dromaeojs', 14:28:31 INFO - 'system_bits': '32', 14:28:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:28:31 INFO - 'title': 'talos-linux64-ix-019', 14:28:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:28:31 INFO - 'use_talos_json': True, 14:28:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:28:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:28:31 INFO - 'work_dir': 'build'} 14:28:31 INFO - ##### 14:28:31 INFO - ##### Running clobber step. 14:28:31 INFO - ##### 14:28:31 INFO - Running pre-action listener: _resource_record_pre_action 14:28:31 INFO - Running main action method: clobber 14:28:31 INFO - rmtree: /builds/slave/test/build 14:28:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:31 INFO - Running post-action listener: _resource_record_post_action 14:28:31 INFO - ##### 14:28:31 INFO - ##### Finished clobber step (success) 14:28:31 INFO - ##### 14:28:31 INFO - ##### 14:28:31 INFO - ##### Running read-buildbot-config step. 14:28:31 INFO - ##### 14:28:31 INFO - Running pre-action listener: _resource_record_pre_action 14:28:31 INFO - Running main action method: read_buildbot_config 14:28:31 INFO - Using buildbot properties: 14:28:31 INFO - { 14:28:31 INFO - "project": "", 14:28:31 INFO - "product": "firefox", 14:28:31 INFO - "script_repo_revision": "production", 14:28:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:28:31 INFO - "repository": "", 14:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:28:31 INFO - "buildid": "20160609113016", 14:28:31 INFO - "pgo_build": "True", 14:28:31 INFO - "basedir": "/builds/slave/test", 14:28:31 INFO - "buildnumber": 792, 14:28:31 INFO - "slavename": "talos-linux64-ix-019", 14:28:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:28:31 INFO - "platform": "ubuntu64_hw", 14:28:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:28:31 INFO - "branch": "fx-team", 14:28:31 INFO - "repo_path": "integration/fx-team", 14:28:31 INFO - "revision": "afc529c199066e9c9d8a88318f24f631a7678d53", 14:28:31 INFO - "stage_platform": "linux64-pgo", 14:28:31 INFO - "builduid": "8e4747667347419d9e7e78983d3bed2a", 14:28:31 INFO - "slavebuilddir": "test" 14:28:31 INFO - } 14:28:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:28:31 INFO - Running post-action listener: _resource_record_post_action 14:28:31 INFO - ##### 14:28:31 INFO - ##### Finished read-buildbot-config step (success) 14:28:31 INFO - ##### 14:28:31 INFO - ##### 14:28:31 INFO - ##### Running download-and-extract step. 14:28:31 INFO - ##### 14:28:31 INFO - Running pre-action listener: _resource_record_pre_action 14:28:31 INFO - Running main action method: download_and_extract 14:28:31 INFO - mkdir: /builds/slave/test/build/tests 14:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:31 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:28:32 INFO - Downloaded 1361 bytes. 14:28:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:32 INFO - Using the following test package requirements: 14:28:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:28:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:28:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'jsshell-linux-x86_64.zip'], 14:28:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:28:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:28:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:28:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:28:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:28:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:32 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:34 INFO - Downloaded 24452351 bytes. 14:28:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:28:35 INFO - Return code: 0 14:28:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:35 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:36 INFO - Downloaded 24452351 bytes. 14:28:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:28:38 INFO - Return code: 0 14:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:38 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:28:39 INFO - Downloaded 10833377 bytes. 14:28:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:28:39 INFO - Return code: 0 14:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:39 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:28:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:28:40 INFO - Downloaded 59291515 bytes. 14:28:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:40 INFO - mkdir: /builds/slave/test/properties 14:28:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:40 INFO - Contents: 14:28:40 INFO - build_url:https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:41 INFO - Running post-action listener: _resource_record_post_action 14:28:41 INFO - Running post-action listener: set_extra_try_arguments 14:28:41 INFO - ##### 14:28:41 INFO - ##### Finished download-and-extract step (success) 14:28:41 INFO - ##### 14:28:41 INFO - ##### 14:28:41 INFO - ##### Running populate-webroot step. 14:28:41 INFO - ##### 14:28:41 INFO - Running pre-action listener: _resource_record_pre_action 14:28:41 INFO - Running main action method: populate_webroot 14:28:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:41 INFO - '--tppagecycles', 14:28:41 INFO - '7'], 14:28:41 INFO - 'tests': ['tsvgm']}}, 14:28:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['damp', 'tps']}, 14:28:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'tests': ['damp', 'tps']}, 14:28:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['dromaeo_dom']}, 14:28:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['a11yr', 14:28:41 INFO - 'ts_paint', 14:28:41 INFO - 'tpaint', 14:28:41 INFO - 'sessionrestore', 14:28:41 INFO - 'sessionrestore_no_auto_restore', 14:28:41 INFO - 'tabpaint']}, 14:28:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['tsvgx', 14:28:41 INFO - 'tsvgr_opacity', 14:28:41 INFO - 'tart', 14:28:41 INFO - 'tscrollx', 14:28:41 INFO - 'cart']}, 14:28:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:41 INFO - 'tsvgr_opacity', 14:28:41 INFO - 'tart', 14:28:41 INFO - 'tscrollx', 14:28:41 INFO - 'cart']}, 14:28:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'talos_options': ['--disable-e10s'], 14:28:41 INFO - 'tests': ['tp5o']}, 14:28:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'tests': ['tp5o']}, 14:28:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'talos_options': ['--disable-e10s', 14:28:41 INFO - '--xperf_path', 14:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:41 INFO - 'tests': ['tp5n']}, 14:28:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:41 INFO - 'talos_options': ['--xperf_path', 14:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:41 INFO - 'tests': ['tp5n']}}, 14:28:41 INFO - 'talos.zip': {'path': '', 14:28:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:41 INFO - Running post-action listener: _resource_record_post_action 14:28:41 INFO - ##### 14:28:41 INFO - ##### Finished populate-webroot step (success) 14:28:41 INFO - ##### 14:28:41 INFO - ##### 14:28:41 INFO - ##### Running create-virtualenv step. 14:28:41 INFO - ##### 14:28:41 INFO - Running pre-action listener: _resource_record_pre_action 14:28:41 INFO - Running main action method: create_virtualenv 14:28:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:28:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:41 INFO - Using real prefix '/usr' 14:28:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:44 INFO - Installing pip.................done. 14:28:44 INFO - Return code: 0 14:28:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:28:44 INFO - Using env: {'DISPLAY': ':0', 14:28:44 INFO - 'HOME': '/home/cltbld', 14:28:44 INFO - 'LANG': 'en_US.UTF-8', 14:28:44 INFO - 'LANGUAGE': 'en_US:en', 14:28:44 INFO - 'LOGNAME': 'cltbld', 14:28:44 INFO - 'MAIL': '/var/mail/cltbld', 14:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:44 INFO - 'MOZ_NO_REMOTE': '1', 14:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:44 INFO - 'NO_EM_RESTART': '1', 14:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:44 INFO - 'PWD': '/builds/slave/test', 14:28:44 INFO - 'SHELL': '/bin/bash', 14:28:44 INFO - 'SHLVL': '1', 14:28:44 INFO - 'TERM': 'linux', 14:28:44 INFO - 'TMOUT': '86400', 14:28:44 INFO - 'USER': 'cltbld', 14:28:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:44 INFO - '_': '/tools/buildbot/bin/python'} 14:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:28:44 INFO - Cleaning up... 14:28:44 INFO - Return code: 0 14:28:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:28:44 INFO - Using env: {'DISPLAY': ':0', 14:28:44 INFO - 'HOME': '/home/cltbld', 14:28:44 INFO - 'LANG': 'en_US.UTF-8', 14:28:44 INFO - 'LANGUAGE': 'en_US:en', 14:28:44 INFO - 'LOGNAME': 'cltbld', 14:28:44 INFO - 'MAIL': '/var/mail/cltbld', 14:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:44 INFO - 'MOZ_NO_REMOTE': '1', 14:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:44 INFO - 'NO_EM_RESTART': '1', 14:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:44 INFO - 'PWD': '/builds/slave/test', 14:28:44 INFO - 'SHELL': '/bin/bash', 14:28:44 INFO - 'SHLVL': '1', 14:28:44 INFO - 'TERM': 'linux', 14:28:44 INFO - 'TMOUT': '86400', 14:28:44 INFO - 'USER': 'cltbld', 14:28:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:44 INFO - '_': '/tools/buildbot/bin/python'} 14:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:44 INFO - Downloading/unpacking psutil>=3.1.1 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:46 INFO - Installing collected packages: psutil 14:28:46 INFO - Running setup.py install for psutil 14:28:46 INFO - building 'psutil._psutil_linux' extension 14:28:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:28:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:28:47 INFO - building 'psutil._psutil_posix' extension 14:28:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:28:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:47 INFO - Successfully installed psutil 14:28:47 INFO - Cleaning up... 14:28:47 INFO - Return code: 0 14:28:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:28:47 INFO - Using env: {'DISPLAY': ':0', 14:28:47 INFO - 'HOME': '/home/cltbld', 14:28:47 INFO - 'LANG': 'en_US.UTF-8', 14:28:47 INFO - 'LANGUAGE': 'en_US:en', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MAIL': '/var/mail/cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SHLVL': '1', 14:28:47 INFO - 'TERM': 'linux', 14:28:47 INFO - 'TMOUT': '86400', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - '_': '/tools/buildbot/bin/python'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:49 INFO - Installing collected packages: mozsystemmonitor 14:28:49 INFO - Running setup.py install for mozsystemmonitor 14:28:49 INFO - Successfully installed mozsystemmonitor 14:28:49 INFO - Cleaning up... 14:28:49 INFO - Return code: 0 14:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:28:49 INFO - Using env: {'DISPLAY': ':0', 14:28:49 INFO - 'HOME': '/home/cltbld', 14:28:49 INFO - 'LANG': 'en_US.UTF-8', 14:28:49 INFO - 'LANGUAGE': 'en_US:en', 14:28:49 INFO - 'LOGNAME': 'cltbld', 14:28:49 INFO - 'MAIL': '/var/mail/cltbld', 14:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:49 INFO - 'MOZ_NO_REMOTE': '1', 14:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:49 INFO - 'NO_EM_RESTART': '1', 14:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:49 INFO - 'PWD': '/builds/slave/test', 14:28:49 INFO - 'SHELL': '/bin/bash', 14:28:49 INFO - 'SHLVL': '1', 14:28:49 INFO - 'TERM': 'linux', 14:28:49 INFO - 'TMOUT': '86400', 14:28:49 INFO - 'USER': 'cltbld', 14:28:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:49 INFO - '_': '/tools/buildbot/bin/python'} 14:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:51 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:51 INFO - warning: no files found matching '*.txt' 14:28:51 INFO - no previously-included directories found matching 'build' 14:28:51 INFO - no previously-included directories found matching 'dist' 14:28:51 INFO - no previously-included directories found matching '.git*' 14:28:51 INFO - Installing collected packages: jsonschema, functools32 14:28:52 INFO - Running setup.py install for functools32 14:28:52 INFO - warning: no files found matching '*.txt' 14:28:52 INFO - no previously-included directories found matching 'build' 14:28:52 INFO - no previously-included directories found matching 'dist' 14:28:52 INFO - no previously-included directories found matching '.git*' 14:28:52 INFO - Successfully installed jsonschema functools32 14:28:52 INFO - Cleaning up... 14:28:52 INFO - Return code: 0 14:28:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:28:52 INFO - Using env: {'DISPLAY': ':0', 14:28:52 INFO - 'HOME': '/home/cltbld', 14:28:52 INFO - 'LANG': 'en_US.UTF-8', 14:28:52 INFO - 'LANGUAGE': 'en_US:en', 14:28:52 INFO - 'LOGNAME': 'cltbld', 14:28:52 INFO - 'MAIL': '/var/mail/cltbld', 14:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:52 INFO - 'MOZ_NO_REMOTE': '1', 14:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:52 INFO - 'NO_EM_RESTART': '1', 14:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:52 INFO - 'PWD': '/builds/slave/test', 14:28:52 INFO - 'SHELL': '/bin/bash', 14:28:52 INFO - 'SHLVL': '1', 14:28:52 INFO - 'TERM': 'linux', 14:28:52 INFO - 'TMOUT': '86400', 14:28:52 INFO - 'USER': 'cltbld', 14:28:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:52 INFO - '_': '/tools/buildbot/bin/python'} 14:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - Downloading docopt-0.6.1.tar.gz 14:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:55 INFO - Running setup.py install for blobuploader 14:28:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:55 INFO - Running setup.py install for requests 14:28:55 INFO - Running setup.py install for docopt 14:28:55 INFO - Successfully installed blobuploader requests docopt 14:28:55 INFO - Cleaning up... 14:28:55 INFO - Return code: 0 14:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:55 INFO - Using env: {'DISPLAY': ':0', 14:28:55 INFO - 'HOME': '/home/cltbld', 14:28:55 INFO - 'LANG': 'en_US.UTF-8', 14:28:55 INFO - 'LANGUAGE': 'en_US:en', 14:28:55 INFO - 'LOGNAME': 'cltbld', 14:28:55 INFO - 'MAIL': '/var/mail/cltbld', 14:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:55 INFO - 'MOZ_NO_REMOTE': '1', 14:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:55 INFO - 'NO_EM_RESTART': '1', 14:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:55 INFO - 'PWD': '/builds/slave/test', 14:28:55 INFO - 'SHELL': '/bin/bash', 14:28:55 INFO - 'SHLVL': '1', 14:28:55 INFO - 'TERM': 'linux', 14:28:55 INFO - 'TMOUT': '86400', 14:28:55 INFO - 'USER': 'cltbld', 14:28:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:55 INFO - '_': '/tools/buildbot/bin/python'} 14:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:55 INFO - Running setup.py (path:/tmp/pip-W27v8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:55 INFO - Running setup.py (path:/tmp/pip-0Av4Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:56 INFO - Running setup.py (path:/tmp/pip-vHR5oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:56 INFO - Running setup.py (path:/tmp/pip-3TESQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:56 INFO - Running setup.py (path:/tmp/pip-8lJrkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:56 INFO - Running setup.py (path:/tmp/pip-yL1nZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:56 INFO - Running setup.py (path:/tmp/pip-Yg2V3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:56 INFO - Running setup.py (path:/tmp/pip-dJMRhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:56 INFO - Running setup.py (path:/tmp/pip-5wmDZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:56 INFO - Running setup.py (path:/tmp/pip-f2jn0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:56 INFO - Running setup.py (path:/tmp/pip-pYOVge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:56 INFO - Running setup.py (path:/tmp/pip-KCiWsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:56 INFO - Running setup.py (path:/tmp/pip-ZAWRga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:56 INFO - Running setup.py (path:/tmp/pip-En8n02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:56 INFO - Running setup.py (path:/tmp/pip-7T7UjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:56 INFO - Running setup.py (path:/tmp/pip-qvC95L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:57 INFO - Running setup.py (path:/tmp/pip-G9gi9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:57 INFO - Running setup.py install for manifestparser 14:28:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozcrash 14:28:57 INFO - Running setup.py install for mozdebug 14:28:57 INFO - Running setup.py install for mozdevice 14:28:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozfile 14:28:57 INFO - Running setup.py install for mozhttpd 14:28:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozinfo 14:28:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozInstall 14:28:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozleak 14:28:57 INFO - Running setup.py install for mozlog 14:28:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for moznetwork 14:28:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozprocess 14:28:58 INFO - Running setup.py install for mozprofile 14:28:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozrunner 14:28:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozscreenshot 14:28:58 INFO - Running setup.py install for moztest 14:28:58 INFO - Running setup.py install for mozversion 14:28:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:58 INFO - Cleaning up... 14:28:58 INFO - Return code: 0 14:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:58 INFO - Using env: {'DISPLAY': ':0', 14:28:58 INFO - 'HOME': '/home/cltbld', 14:28:58 INFO - 'LANG': 'en_US.UTF-8', 14:28:58 INFO - 'LANGUAGE': 'en_US:en', 14:28:58 INFO - 'LOGNAME': 'cltbld', 14:28:58 INFO - 'MAIL': '/var/mail/cltbld', 14:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:58 INFO - 'MOZ_NO_REMOTE': '1', 14:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:58 INFO - 'NO_EM_RESTART': '1', 14:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:58 INFO - 'PWD': '/builds/slave/test', 14:28:58 INFO - 'SHELL': '/bin/bash', 14:28:58 INFO - 'SHLVL': '1', 14:28:58 INFO - 'TERM': 'linux', 14:28:58 INFO - 'TMOUT': '86400', 14:28:58 INFO - 'USER': 'cltbld', 14:28:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:58 INFO - '_': '/tools/buildbot/bin/python'} 14:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:59 INFO - Running setup.py (path:/tmp/pip-AVejS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:59 INFO - Running setup.py (path:/tmp/pip-lqQaWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:59 INFO - Running setup.py (path:/tmp/pip-aTNmuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:59 INFO - Running setup.py (path:/tmp/pip-NOeMSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:59 INFO - Running setup.py (path:/tmp/pip-vxWAtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:59 INFO - Running setup.py (path:/tmp/pip-bbZAx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:59 INFO - Running setup.py (path:/tmp/pip-FBWsOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:59 INFO - Running setup.py (path:/tmp/pip-xDGcAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:59 INFO - Running setup.py (path:/tmp/pip-eEQ_h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:59 INFO - Running setup.py (path:/tmp/pip-nX6zbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:59 INFO - Running setup.py (path:/tmp/pip-U6YB53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:59 INFO - Running setup.py (path:/tmp/pip-xbCqXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:00 INFO - Running setup.py (path:/tmp/pip-4bvQXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:00 INFO - Running setup.py (path:/tmp/pip-VRbdq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:00 INFO - Running setup.py (path:/tmp/pip-J6u6FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:00 INFO - Running setup.py (path:/tmp/pip-SywOG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:00 INFO - Running setup.py (path:/tmp/pip-E6RxlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:29:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:02 INFO - Downloading blessings-1.6.tar.gz 14:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:29:02 INFO - Installing collected packages: blessings 14:29:02 INFO - Running setup.py install for blessings 14:29:02 INFO - Successfully installed blessings 14:29:02 INFO - Cleaning up... 14:29:02 INFO - Return code: 0 14:29:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:02 INFO - Reading from file tmpfile_stdout 14:29:02 INFO - Current package versions: 14:29:02 INFO - argparse == 1.2.1 14:29:02 INFO - blessings == 1.6 14:29:02 INFO - blobuploader == 1.2.4 14:29:02 INFO - docopt == 0.6.1 14:29:02 INFO - functools32 == 3.2.3-2 14:29:02 INFO - jsonschema == 2.5.1 14:29:02 INFO - manifestparser == 1.1 14:29:02 INFO - mozInstall == 1.12 14:29:02 INFO - mozcrash == 0.17 14:29:02 INFO - mozdebug == 0.1 14:29:02 INFO - mozdevice == 0.48 14:29:02 INFO - mozfile == 1.2 14:29:02 INFO - mozhttpd == 0.7 14:29:02 INFO - mozinfo == 0.9 14:29:02 INFO - mozleak == 0.1 14:29:02 INFO - mozlog == 3.2 14:29:02 INFO - moznetwork == 0.27 14:29:02 INFO - mozprocess == 0.22 14:29:02 INFO - mozprofile == 0.28 14:29:02 INFO - mozrunner == 6.11 14:29:02 INFO - mozscreenshot == 0.1 14:29:02 INFO - mozsystemmonitor == 0.3 14:29:02 INFO - moztest == 0.7 14:29:02 INFO - mozversion == 1.4 14:29:02 INFO - psutil == 3.1.1 14:29:02 INFO - requests == 1.2.3 14:29:02 INFO - wsgiref == 0.1.2 14:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:29:02 INFO - Using env: {'DISPLAY': ':0', 14:29:02 INFO - 'HOME': '/home/cltbld', 14:29:02 INFO - 'LANG': 'en_US.UTF-8', 14:29:02 INFO - 'LANGUAGE': 'en_US:en', 14:29:02 INFO - 'LOGNAME': 'cltbld', 14:29:02 INFO - 'MAIL': '/var/mail/cltbld', 14:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:02 INFO - 'MOZ_NO_REMOTE': '1', 14:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:02 INFO - 'NO_EM_RESTART': '1', 14:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:02 INFO - 'PWD': '/builds/slave/test', 14:29:02 INFO - 'SHELL': '/bin/bash', 14:29:02 INFO - 'SHLVL': '1', 14:29:02 INFO - 'TERM': 'linux', 14:29:02 INFO - 'TMOUT': '86400', 14:29:02 INFO - 'USER': 'cltbld', 14:29:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:02 INFO - '_': '/tools/buildbot/bin/python'} 14:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:29:02 INFO - Cleaning up... 14:29:02 INFO - Return code: 0 14:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:29:02 INFO - Using env: {'DISPLAY': ':0', 14:29:02 INFO - 'HOME': '/home/cltbld', 14:29:02 INFO - 'LANG': 'en_US.UTF-8', 14:29:02 INFO - 'LANGUAGE': 'en_US:en', 14:29:02 INFO - 'LOGNAME': 'cltbld', 14:29:02 INFO - 'MAIL': '/var/mail/cltbld', 14:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:02 INFO - 'MOZ_NO_REMOTE': '1', 14:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:02 INFO - 'NO_EM_RESTART': '1', 14:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:02 INFO - 'PWD': '/builds/slave/test', 14:29:02 INFO - 'SHELL': '/bin/bash', 14:29:02 INFO - 'SHLVL': '1', 14:29:02 INFO - 'TERM': 'linux', 14:29:02 INFO - 'TMOUT': '86400', 14:29:02 INFO - 'USER': 'cltbld', 14:29:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:02 INFO - '_': '/tools/buildbot/bin/python'} 14:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:29:03 INFO - Cleaning up... 14:29:03 INFO - Return code: 0 14:29:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24ccc6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1739350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:29:03 INFO - Using env: {'DISPLAY': ':0', 14:29:03 INFO - 'HOME': '/home/cltbld', 14:29:03 INFO - 'LANG': 'en_US.UTF-8', 14:29:03 INFO - 'LANGUAGE': 'en_US:en', 14:29:03 INFO - 'LOGNAME': 'cltbld', 14:29:03 INFO - 'MAIL': '/var/mail/cltbld', 14:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:03 INFO - 'MOZ_NO_REMOTE': '1', 14:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:03 INFO - 'NO_EM_RESTART': '1', 14:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:03 INFO - 'PWD': '/builds/slave/test', 14:29:03 INFO - 'SHELL': '/bin/bash', 14:29:03 INFO - 'SHLVL': '1', 14:29:03 INFO - 'TERM': 'linux', 14:29:03 INFO - 'TMOUT': '86400', 14:29:03 INFO - 'USER': 'cltbld', 14:29:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:03 INFO - '_': '/tools/buildbot/bin/python'} 14:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:03 INFO - Downloading/unpacking flake8 14:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:29:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:29:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:06 INFO - no previously-included directories found matching 'docs/_build' 14:29:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:29:06 INFO - Running setup.py install for pep8 14:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:06 INFO - no previously-included directories found matching 'docs/_build' 14:29:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:29:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:29:06 INFO - Cleaning up... 14:29:06 INFO - Return code: 0 14:29:06 INFO - Running post-action listener: _resource_record_post_action 14:29:06 INFO - Running post-action listener: _start_resource_monitoring 14:29:06 INFO - Starting resource monitoring. 14:29:06 INFO - ##### 14:29:06 INFO - ##### Finished create-virtualenv step (success) 14:29:06 INFO - ##### 14:29:06 INFO - ##### 14:29:06 INFO - ##### Running install step. 14:29:06 INFO - ##### 14:29:06 INFO - Running pre-action listener: _resource_record_pre_action 14:29:06 INFO - Running main action method: install 14:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:06 INFO - Reading from file tmpfile_stdout 14:29:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:29:06 INFO - Reading from file tmpfile_stdout 14:29:06 INFO - Output received: 14:29:06 INFO - Usage: mozinstall [options] installer 14:29:06 INFO - Options: 14:29:06 INFO - -h, --help show this help message and exit 14:29:06 INFO - -d DEST, --destination=DEST 14:29:06 INFO - Directory to install application into. [default: 14:29:06 INFO - "/builds/slave/test"] 14:29:06 INFO - --app=APP Application being installed. [default: firefox] 14:29:06 INFO - mkdir: /builds/slave/test/build/application 14:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:29:23 INFO - Reading from file tmpfile_stdout 14:29:23 INFO - Output received: 14:29:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:29:23 INFO - Running post-action listener: _resource_record_post_action 14:29:23 INFO - ##### 14:29:23 INFO - ##### Finished install step (success) 14:29:23 INFO - ##### 14:29:23 INFO - ##### 14:29:23 INFO - ##### Running run-tests step. 14:29:23 INFO - ##### 14:29:23 INFO - Running pre-action listener: _resource_record_pre_action 14:29:23 INFO - Running main action method: run_tests 14:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:23 INFO - Python 2.7.3 14:29:23 INFO - Return code: 0 14:29:23 INFO - grabbing minidump binary from tooltool 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c81c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:29:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:29:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:29:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:23 INFO - Return code: 0 14:29:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:29:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:29:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:29:24 INFO - Return code: 0 14:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:29:24 INFO - Using env: {'DISPLAY': ':0', 14:29:24 INFO - 'HOME': '/home/cltbld', 14:29:24 INFO - 'LANG': 'en_US.UTF-8', 14:29:24 INFO - 'LANGUAGE': 'en_US:en', 14:29:24 INFO - 'LOGNAME': 'cltbld', 14:29:24 INFO - 'MAIL': '/var/mail/cltbld', 14:29:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:24 INFO - 'MOZ_NO_REMOTE': '1', 14:29:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:24 INFO - 'NO_EM_RESTART': '1', 14:29:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:24 INFO - 'PWD': '/builds/slave/test', 14:29:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:24 INFO - 'SHELL': '/bin/bash', 14:29:24 INFO - 'SHLVL': '1', 14:29:24 INFO - 'TERM': 'linux', 14:29:24 INFO - 'TMOUT': '86400', 14:29:24 INFO - 'USER': 'cltbld', 14:29:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990', 14:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:24 INFO - '_': '/tools/buildbot/bin/python'} 14:29:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:29:24 INFO - mozversion application_buildid: 20160609113016 14:29:24 INFO - mozversion application_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:29:24 INFO - mozversion application_display_name: Nightly 14:29:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:24 INFO - mozversion application_name: Firefox 14:29:24 INFO - mozversion application_remotingname: firefox 14:29:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:29:24 INFO - mozversion application_vendor: Mozilla 14:29:24 INFO - mozversion application_version: 50.0a1 14:29:24 INFO - mozversion platform_buildid: 20160609113016 14:29:24 INFO - mozversion platform_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:29:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:29:24 INFO - mozversion platform_version: 50.0a1 14:29:24 INFO - using testdate: 1465507764 14:29:24 INFO - actual date: 1465507764 14:29:24 INFO - starting webserver on 'localhost:50454' 14:29:24 INFO - SUITE-START | Running 2 tests 14:29:24 INFO - TEST-START | dromaeo_css 14:29:24 INFO - operating with platform_type : linux_ 14:29:24 INFO - Initialising browser for dromaeo_css test... 14:29:24 INFO - TEST-INFO | started process 11039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyZsNek/profile http://localhost:50454/getInfo.html) 14:29:29 INFO - PROCESS | 11039 | __metrics Screen width/height:1600/1200 14:29:29 INFO - PROCESS | 11039 | colorDepth:24 14:29:29 INFO - PROCESS | 11039 | Browser inner width/height: 1024/697 14:29:29 INFO - PROCESS | 11039 | __metrics 14:29:30 ERROR - PROCESS | 11039 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:29:30 INFO - PROCESS | 11039 | console.error: PushService: 14:29:30 INFO - PROCESS | 11039 | stateChangeProcessEnqueue: Error transitioning state 14:29:30 INFO - PROCESS | 11039 | UnknownError 14:29:31 INFO - TEST-INFO | 11039: exit 0 14:29:31 INFO - Browser initialized. 14:29:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:31 INFO - TEST-INFO | started process 11122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyZsNek/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:43 INFO - PROCESS | 11122 | RSS: Main: 173920256 14:29:43 INFO - PROCESS | 11122 | 14:30:34 INFO - PROCESS | 11122 | 1465507834094 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:42 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50454/tests/dromaeo/cssquery-ext.html) 14:32:43 INFO - PROCESS | 11122 | RSS: Main: 264228864 14:32:43 INFO - PROCESS | 11122 | 14:35:46 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-ext.html (next: http://localhost:50454/tests/dromaeo/cssquery-jquery.html) 14:35:47 INFO - PROCESS | 11122 | RSS: Main: 264511488 14:35:47 INFO - PROCESS | 11122 | 14:38:49 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50454/tests/dromaeo/cssquery-mootools.html) 14:38:49 INFO - PROCESS | 11122 | RSS: Main: 261423104 14:38:49 INFO - PROCESS | 11122 | 14:41:51 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50454/tests/dromaeo/cssquery-prototype.html) 14:41:52 INFO - PROCESS | 11122 | RSS: Main: 255709184 14:41:52 INFO - PROCESS | 11122 | 14:44:55 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50454/tests/dromaeo/cssquery-yui.html) 14:44:55 INFO - PROCESS | 11122 | RSS: Main: 242503680 14:44:55 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-yui.html (next: http://localhost:50454/tests/dromaeo/cssquery-dojo.html) 14:47:58 INFO - PROCESS | 11122 | RSS: Main: 275431424 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | __start_tp_report 14:47:58 INFO - PROCESS | 11122 | _x_x_mozilla_page_load 14:47:58 INFO - PROCESS | 11122 | _x_x_mozilla_page_load_details 14:47:58 INFO - PROCESS | 11122 | |i|pagename|runs| 14:47:58 INFO - PROCESS | 11122 | |0;dojo.html;3047.9238019049526;3051.2760290435904;3072.5237588173813;3074.523448865426;3111.0355789705177;5270.156774916014;5276.788928442863;5325.7869685212545;5342.465753424665;5349.438308977559;5346.91979620306;5352.57179425646;5360.865978350544;5366.382865970415;5427.782888684448;4769.833055843046;4878.609711223111;4882.902341953159;4904.926426103593;5044.4955504449445;4906.533879281463;4947.109520286347;4981.825636102737;5011.373578302712;5013.724245166514;4732.077244937239;4741.786619602091;4788.545088216596;4838.491958344358;4841.080194763019;4782.641301902337;4783.425988881357;4791.808327666924;4798.49615790344;4881.511848815126;4771.785269662873;4781.0676918001;4810.927836082462;4812.1578723723205;4834.613230941552;5167.741612919376;5271.525562699376;5369.4630536946;5376.838694839161;5377.381601115882;5795.420457954213;5796.1305804129715;5813.447722466359;5821.27234095738;5827.125931110325;5862.384449632812;5870.501007414375;5889.705514724246;5891.941080589225;5898.646081235097;5243.475652434726;5323.30796996388;5384.16545435462;5385.407605163429;5450.373207081237;5921.259842519685;5922.763089476459;5928.347881733006;5928.822135335947;5929.881402371929;5569.66582005081;5633.211350410946;5678.545716342683;5679.31848178213;5684.8294551163535;5658.094704847204;5750.367459579443;5755.906377788207;5784.595078344475;5787.247657804459;5748.511376532958;5758.62568933018;5762.88474230513;5764;5767.596268261182;5539.390667026624;5661.773529058792;5752.712364381764;5760.971195143998;5766.596338256281;4365.781710914442;4372.344148377705;4395.1429471252795;4432.180046691373;4439.9778001110435;3886.378179491268;3900.902477438087;3919.784411857318;3920.5491368492417;3951.229510245532;5339.492748188916;5339.599530035263;5429.972850135724;5462.317210348707;5502.394736578973;5779.971100144472;5793.768249270066;5818.8254352369495;5839.562032847553;5866.970665146732;5489.807856725075;5505.091659876076;5506.03644362235;5509.889802204014;5515.172724091419;4906.1414252505665;4946.208606622923;4962.727050012212;4976.601871850244;5031.547160755549;5950.9702451487465;5957.046872500379;5957.553183511254;5988.401159883977;5996.580239383288;5809.390014048633;5824;5824.213731146241;5825.41745825431;5826.533877289722;5781.4218578141845;5923.614965027259;5964.940350596438;5970.701464926823;5975.043992961106;5755.913661295168;5760.0783874579865;5763.135529670583;5765.740541675718;5766.163906233656;5814.709264536841;5870.706464676835;5872.119182122716;5880.059190529495;5880.941190588211;5557.36090349615;5559.63862348946;5569.387367389503;5601.943980560142;5620.522255608319;5548.639338442988;5582.106862901916;5606.85982850432;5610.915836262541;5615.045442274742;5362.946370536245;5507.03626865305;5519.199716041232;5523.254360661259;5566.721663916869;5641.915371269516;5671.206031155559;5679.034564124191;5773.393793651606;5773.8556536086935;5590.720463976866;5600.047991841316;5605.299337582802;5606.2431571738925;5651.124075768263 14:47:58 INFO - PROCESS | 11122 | |1;ext.html;634.3656343656344;636.6848410037031;640.8654182621649;653.1476423267637;657.2113463843383;32251;34942.30115397691;43359.78320108395;44875.77562112185;44976;46464.53535464653;46866.29700554494;47010;47026.764866175705;47123;8826.558672066387;8952.8657070144;8974.371793974424;8974.41666291689;8975.640974361018;8905.955470222672;8996.505192214425;8997.595108220146;9008.59461324242;9009.099090091004;8999.190072893438;9007.144321289466;9034.457932524037;9049.773755656128;9051.637934482613;8930.776730581754;8986.415882967585;8994.86507702385;8996;8999.730008099768;8842.292616590657;8848;8875.156860098345;8889.688860889903;8905.020447750741;42929;43300.35049474229;43312.13375732468;43465.78267108676;43843.56156438427;3650.0509867434394;3741.8877433677035;3859.4982652255026;4029.8186581603604;4231.513375961742;32346;33099.83450082758;33449.99650010504;33461.665383346095;33478.497822532685;4361.454818147731;4421.9115617687785;4471.6199123074575;4521.864344069683;4619.514950930171;333681;334340;335620;336252;336857;57979.71010144922;58379.70810145922;58477.70761146167;58536;58567.414325856196;61777;62278.37721622817;62325.68837155785;62348.37651623516;62408;17559.297628094733;17729.645407091786;17747.73378399325;17777.733334;17784.288628454717;12305.630831075083;12326.75346493065;12336.444859981322;12336.876631233752;12359.38203089842;15714.842851571566;16938.153092345332;16946;16958.57603559921;16968.57578560546;5235;6153.569250152446;6162.137300777895;6279;6317.557770956081;952.4808979106404;995.9800803983879;1007.496251874063;1078.541619811577;1114.4817659788237;30823.8458807709;32111.35777284441;32376.35247295041;32393.19017024546;33253.50119748206;1121.966341009771;1171.9707007324714;1178.157617303632;1178.2871362825367;1239.6590937492263;17373.913130434266;17380.62336864733;17456.47630571085;17486.912565437346;17634.206460709298;496070;496185;499477;499776;500259;59701.104483432784;59819.700901496086;59857.401425986056;59880.70059649674;59929.40070599238;1257.6604316834403;1302.426932149851;1354.1536539662711;1386.2791348498724;1398.5454727213696;29827.91776531062;34076;34130.31739365248;34319.828400857834;34383.31233375368;50917;51006;51367.22949155691;51485;51508.227376588635;388295;391139;391805;392085;392568;36530.63469365379;41164.794176030126;42141.57858421376;42200.57799421967;42305.365419519345;48351.27473087977;49294;49588;49944.750276248385;50400;40653.1509038255;41575.7921210392;41612.79193604013;42257.57742422659;42999;41063;41280.79359603183;41305.1738965213;41933.58066419297;42223;40461.393079104426;41012.79493602513;41089.79455102705;41868.23185913282;41919.79040104902;36485.27029459449;36767.448488273236;36987.26025479529;37718.43422348612;38117.618823811405;28042.964790244438;28124.890877618247;28137.71720173158;28150.961782267874;28493.930765772184 14:47:58 INFO - PROCESS | 11122 | |2;jquery.html;374.1021548284117;376.28130271182033;382.42826973674363;391.9686425085993;399.50062421972535;14711.852881471183;14924.253787310645;17368.30526778929;20113.798862011376;20272.493187670298;17611.383601573947;17953.64092718145;18304.542386440346;18657;18748;5593.496585307312;5769.1346298055205;5800.564957628174;5826.737796799133;5829.067349224125;3905.082305658168;5390.487903649167;5474.863128421782;5650.0959846424585;5674.375818659944;5626.54987600993;5680.886382272352;5681.233033540481;5716.599838011341;5735.053716136832;5793.246877905866;6157.199564056688;6314.778982735582;6361;6395.296517383107;5504.0643090674685;5565.749541270652;5603.691796951166;5611.915821262684;5636.71816409182;13570.796438053438;13690.794638080437;13793.172409655454;13796.689314515104;16489.752653710202;2346.248846086688;2447.229122826304;2609.8042646801377;2647.7352264773367;2894.8263104213815;14149.929250353785;15502.767458488019;15830.366785328573;15896.046237225804;16273.291304413104;1913.9808601913942;1960.1179469238757;1999.8900060496667;2009.4072248686673;2040.1737296394983;76600;80682.78975815309;87826;90704;93696.53151734266;16374.426895058616;17730.404263616336;17872.642547148986;17951.192196351196;18138.72791908096;31259.218519537193;31847.203819904225;31961.20096997547;32026.67973320237;32145;9813.214942804558;9934.354266972623;9957.452340121363;10156.39061656303;10181;7946.523208607502;8184.304334131546;8278.337732981347;8369.916300836914;8443.957780211182;8606.87089693655;8677.783055423664;8891.4665120093;9008.684696035738;9105.317101217302;2738.561830107173;3018.5623084652602;3244.2051697334305;3453.723702103826;3568.7323450741296;823.189158678701;845.4842546046906;931.0240770147898;986.3539381704994;1085.403028334413;18073.186706598233;18679.90660046691;19183.424497265103;19420.61158776845;19544.90227548853;942.330945029037;1006.6979906028163;1013.2299452416216;1023.3552861697232;1040.2718097331897;10371;10439.217058720626;11023.393713345842;11160.218784684994;11547.422628868522;370468;375305;500137;504406;505373;99903.50048249713;101652.49173754084;102726.48636756917;105596.94403056025;105986;998.650472334677;1006.2201793610011;1040.3601784902382;1047.4710271312938;1053.3521884041259;16522.339106435607;17033.233504492575;17412.564685882953;17638.206280717655;17832.465026049238;41481.96295092647;41552.79223603863;41919;42269.36595951002;42752.358714618684;58277;58399.70800146142;59020.11469828042;59498.70250648719;59967;8338.124496927978;8391.454555453876;8484.830303394021;8730.214280714767;8735.039145693841;8092.514449133071;9305.813883722152;10061.798764024825;10881.510332034919;11589.6523104307;10299.176065914859;10876.347419154876;11097.667069987914;11386.658400248005;11493.597724079616;10445.425501597485;11144.442777860912;11189.608363707232;11312.717182070184;11437.485313160762;9043.638254469748;11166.218364714392;11330.37682927447;11637.592684256011;11646.592369267035;8034.598270086589;8058.395620328616;8208.179182081743;8315.293200078062;8379.58102094905;10492.580296788043;11076.446177691245;11393.658190254306;11440.48517816717;11527.135464840003 14:47:58 INFO - PROCESS | 11122 | |3;mootools.html;1322.9603111906647;1460.6129375715434;1475.712236113958;1608.790857188566;1758.4724582625217;8060.274575288223;8399.49603023819;8412.200840920119;8617.138286171396;8618.439801412904;8415.95792021039;8572.914270857289;8584.656613735444;8585.828283434328;8588.527630980308;2020.75750909891;2218.3123231798113;2274.169927976285;2322.094383190553;2354.576176288276;2329.522447898177;2334.9883250583725;2337.754535773745;2338.205010296499;2344.0272287000957;2258.2096266306744;2262.061244583496;2290.7365652949875;2293.7591552886956;2295.0819672131115;1945.4455480188149;2229.0860747093693;2245.831562632809;2314.710661167354;2317.073170731704;2277.39648993017;2282.600544904635;2283.2122917593406;2297.0696867768415;2302.044651469638;8671.262942649882;8715.215630593277;8720.476771393736;8730.476171429671;8747.387682862201;4977.303177555145;5189.740512974374;5192.3769147702515;5217.139172036609;5238.869028274324;3014.608100946863;3157.542156387311;3195.328980914011;3238.077148012805;3290.177455636091;1036.2953191829554;1070.2294348069456;1088.6135421925183;1104.265663333882;1108.4956344863149;11872.881271187263;11894.52421903123;11895.94052029743;11896.464659090361;11930.701732456671;4550.817967281272;4627.514111018362;4649.674522783373;4749.501302363202;4755.548222918817;10068.44623545712;10082.445465499468;10083.243756718275;10084.546195421224;10085.243606729524;5037.4458809530925;5044.924326135111;5047.066292735783;5049.747512624354;5050.267711181858;4303.63419109373;4699.812007519661;4807.038592281558;4840.177169881129;4923.77842997066;4017.5379831319187;4032.403415705826;4095.385692146202;4136.689748268892;4145.481814773153;1213.4296880466168;1233.2600439736086;1241.4971936365787;1253.3169422664669;1272.0650322013498;1011.079917275276;1011.6307547745167;1017.8524114003576;1025.7230547752215;1026.0509029148157;6112;6191.349908259568;6193;6195.411435913581;6205.720742566596;430.5651292194906;438.07128886759637;438.4475560793359;439.3760859579405;442.06723812755064;4139.793010349531;4149.419081328617;4213.557576454489;4217.051163488252;4239.491261048694;10320.329178603517;10605.363678179334;10665.41340226295;10668.62659806903;10669.466526673636;10475;10681.198910081775;10684.358938463716;10691.30506517074;10711.196660250513;7643.388528917784;7888.1323054463965;8161.428699991063;8231.218034286732;8237.176282371835;6090.421409966046;6196;6284.528660350584;6293.937060629335;6418.4865210783955;9891.604335826487;10125.240606954361;10285.9485702571;10313.1233845124;10319.380837149494;10407.635732749317;10508.947455262674;10521.21090918169;10601.575936962743;10604.575816967543;7035.12060992376;7714.459987801025;7716.5370077795515;7888.3689304856625;7915.129335773176;8407.789805254917;8429.072801991653;8473.95763021181;8491.023532293866;8504.362172836938;7523.473356865185;7609.239076092346;7732.961335193288;7808.609569521387;7835.216478352119;7533.39732821362;7540.886886696594;7598.0502437195355;7668.079830420385;7772.339351155215;6817.761378351734;6849.452043836382;6883.793486195422;6895.207051189177;6896.862062758817;4959.156943319572;5021.648484606042;5102.056119617882;5105.744712764273;5173.870653233699;5126.820561280338;5198.558122559625;5250.947490525045;5364.329458817648;5365.168398898177 14:47:58 INFO - PROCESS | 11122 | |4;prototype.html;329.12945259787864;330.7502835359304;337.6404129601973;337.64547225413327;340.02413074476254;5281.287026251455;5288.471152884715;5291.841244762659;5313.362396512424;5328.999999999995;5214.452482489341;5219.556337711299;5235.267062611238;5273.525382715555;5290.285811415458;3935.5277366716036;3987.940180897289;4144.5340022686605;4153.940745109992;4165.33354663254;4082.7754473503946;4095.4266402703647;4126.112885729567;4141.420201171838;4158.521769996444;3903.2193561287713;4090.365993271033;4091.1204091120403;4098.262312783698;4121.629053385194;3824.349860523718;3888.727789054753;4002.6777774447282;4135.462389889325;4136.648384887289;3632;3638.981805090984;3675.46705727668;3679.2825399047197;3683.9815800920824;5086.059079070384;5094.59243260542;5099.3228555008545;5117.590592752571;5185.5333020028;4472.396226509412;4675.602573781232;4686.906261874743;4697.201475749131;4704.753240391299;5435.809746658888;5444.210589464506;5470.699111548864;5477.507024367826;5540.639858409231;3979.522457305142;3980.960190398088;3996.72022958393;4027.456293400412;4058.7767672777986;5364;5625.887482250373;5643.407442218549;5679.545636349124;5694.914576281318;3931.941020884689;3936.901577460529;3939.2909276330533;3949.2101579684177;3976.7812770297332;3997.6601988830694;4005.4592629994577;4017.176478821893;4022.517297924268;4027.2549578328103;4437.755923424178;4590.747508887043;4600.35595016698;4609.700369475973;4636.72490065228;5470.972645136749;5478.369987451414;5499.642523235977;5504.697241651747;5510.669359838343;1373.979390309146;1375.8624137586362;1401.509471684902;1418.3121186224673;1420.8792252658434;843.767963809945;891.6210610490516;898.1961144775389;901.783571942729;909.6997990663066;5153.5361817436615;5225.190095535198;5294.338207724035;5300.959130734618;5309.256704061435;5568.248286481355;5648.71756412186;5665.830025099253;5674.290713660793;5679.091345384719;5146.485351464824;5293;5296.25852380667;5326.360836699543;5327.653702509402;2948.7442106788326;2968;2975.8363290018824;2998.130542142798;3009.714077162666;5787.536997040227;5801.12983052537;5811.4479124483105;5824.126381042793;5838.766449341979;5479.479449452296;5747.08046712524;5751.396103409082;5756.194132821408;5773.29687742117;5691.60555663865;5737.790950484094;5754.1944127822135;5756.798512052225;5794.870000349892;5283.947160528345;5535.086710692852;5541.224228608079;5586.748596313095;5596.944030559643;5538.418466061005;5545.279113715191;5554;5561.749721262472;5581.972090139523;5771;5788.37925380894;5794.710264486843;5797.884042319046;5812.476877081083;3937.724359294822;3998.740081894784;4039.5556488785624;4045.453863728477;4055.878323650295;5549.639273447213;5574.888502230014;5599.524040456607;5683.323419591148;5709.286339207599;5443.292371991774;5458.608054945963;5514.80698175562;5521.917171242515;5528.281323427928;5228.816991405282;5426.511613954763;5469.179623056573;5469.507744302873;5485;5191.6884986900905;5374.226505253179;5376.677399356051;5439.4288599696465;5440.211169380497;5326.840194794162;5502.367227768857;5509.47659972302;5549.722513874371;5573.6098473106495;5413.458654134713;5414.918776218438;5441.727913604224;5444.156155795858;5455.454454554513 14:47:58 INFO - PROCESS | 11122 | |5;yui.html;739.7336958694872;751.5302935665209;789.7630710786763;808.385626923538;822.3462347433791;15623.687526249483;15753.763693544577;16169.11069891157;16183;16677.49967500977;15118.319675614597;15172.468963586276;15300.387984480607;15346.462873799419;15354.232288385563;673.1652750589259;790.6600161930368;818.136865606786;825.5789547330875;828.8590939540293;801.1067659559578;803.5982008995502;803.8834369016489;804.0512195609178;804.4368941740776;858.7509622209552;859.4628357276702;859.4757198109148;860.3031544449017;860.5310105992249;698.2389195776602;817.0318172965056;855.670566831768;859.0764927702683;860.5310105992249;627.6641996531833;627.9560430769848;628.5160426471591;628.8302158417201;629.3549112160073;15015.249237538079;15089.39642414302;15097.773533397009;15101.848981510155;15115;13980.370883310276;14232.430702771877;14235.857641423558;14250.857491425057;14388;13216.801747973788;13266.3366831659;13315.733685326337;13433.798493022612;13943.511977080754;4477.843275485375;4515.096980603859;4610.216263235258;4623.445186577598;4759.286107083931;70177.64911175462;70771.64614176948;70919;71278;71773.64113179401;11351.212169228227;11355.318680879174;11371.54513819438;11433.017484042362;11490.199008692553;20922.895385522974;20941.371758847257;20953;20964.580708385747;20987.055582498826;8633.568321583896;8703.129687031373;8758.737237882873;8842.513661748537;9002.909970900208;4784.832530861403;4874.8050077997195;4880.267959805987;4898.657094003385;4931.112399768076;3385.509101180315;3484.3902317094407;3500.5274287971306;3535.292941411728;3538.398472259722;571.8313097636208;590.9822705318848;611.5535658968978;616.7594638091148;618.1191801682585;548.4542879834511;699.6711545573572;732.1264038648391;737.1449119021909;799.1848314718954;9727.124558789743;10320.225983051301;10357.171426285879;10408.583656653649;10479.84280235797;603.9003564411911;644.4511955217198;673.4040374268808;673.6160388578463;763.9313157202005;4638.907221855611;4707.481497398875;4788.767457492068;4806.351142595705;4854.997410668;65374.673126634065;101788;105753.47123264335;106414.86420962604;108558;58758;75202;89210.55394723115;90147.54926225326;92882;78528.60735696285;80733;80928.59535702284;81360.99999999882;81949.59025204837;8963.910360896307;9034.096590340914;9063.68277110298;9319.673811416567;9324.440533568008;47131.52868471271;47331.526684732715;47525;47845.76077119731;48295;47406.28890566575;47426;48716.512834872614;70853.64573177102;71810.28189718245;12606;12671.936640316739;13055.869441305465;13338.533151339656;14118.576442706735;14559.12645241289;14756.335964881391;15230.695386091995;15395.153266570445;16112.436064737678;13826.516071937434;13963.301834908418;14356.784648230076;14397.64005899861;14914.328855201325;14058.718825623635;14333.928330358282;14665.853341466876;14667.266636667911;15117.848821511645;13673.79489307681;14014.78977815354;14219.21794301282;14587.635309116933;15046.849531504546;11408.771824563297;11483.138764592855;11486.827697584376;11538.653840384803;12216.511339546318;11323.603673871376;11485.712857178303;11892.122947234235;12233.143679942319;12275.263484190977 14:47:58 INFO - PROCESS | 11122 | __end_tp_report 14:47:58 INFO - PROCESS | 11122 | __start_cc_report 14:47:58 INFO - PROCESS | 11122 | _x_x_mozilla_cycle_collect,829 14:47:58 INFO - PROCESS | 11122 | __end_cc_report 14:47:58 INFO - PROCESS | 11122 | __startTimestamp1465508878828__endTimestamp 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | ------- Summary: start ------- 14:47:58 INFO - PROCESS | 11122 | Number of tests: 6 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#0] dojo.html Cycles:165 Average:5348.95 Median:5559.64 stddev:627.99 (11.3%) stddev-sans-first:603.42 14:47:58 INFO - PROCESS | 11122 | Values: 3047.9 3051.3 3072.5 3074.5 3111.0 5270.2 5276.8 5325.8 5342.5 5349.4 5346.9 5352.6 5360.9 5366.4 5427.8 4769.8 4878.6 4882.9 4904.9 5044.5 4906.5 4947.1 4981.8 5011.4 5013.7 4732.1 4741.8 4788.5 4838.5 4841.1 4782.6 4783.4 4791.8 4798.5 4881.5 4771.8 4781.1 4810.9 4812.2 4834.6 5167.7 5271.5 5369.5 5376.8 5377.4 5795.4 5796.1 5813.4 5821.3 5827.1 5862.4 5870.5 5889.7 5891.9 5898.6 5243.5 5323.3 5384.2 5385.4 5450.4 5921.3 5922.8 5928.3 5928.8 5929.9 5569.7 5633.2 5678.5 5679.3 5684.8 5658.1 5750.4 5755.9 5784.6 5787.2 5748.5 5758.6 5762.9 5764.0 5767.6 5539.4 5661.8 5752.7 5761.0 5766.6 4365.8 4372.3 4395.1 4432.2 4440.0 3886.4 3900.9 3919.8 3920.5 3951.2 5339.5 5339.6 5430.0 5462.3 5502.4 5780.0 5793.8 5818.8 5839.6 5867.0 5489.8 5505.1 5506.0 5509.9 5515.2 4906.1 4946.2 4962.7 4976.6 5031.5 5951.0 5957.0 5957.6 5988.4 5996.6 5809.4 5824.0 5824.2 5825.4 5826.5 5781.4 5923.6 5964.9 5970.7 5975.0 5755.9 5760.1 5763.1 5765.7 5766.2 5814.7 5870.7 5872.1 5880.1 5880.9 5557.4 5559.6 5569.4 5601.9 5620.5 5548.6 5582.1 5606.9 5610.9 5615.0 5362.9 5507.0 5519.2 5523.3 5566.7 5641.9 5671.2 5679.0 5773.4 5773.9 5590.7 5600.0 5605.3 5606.2 5651.1 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#1] ext.html Cycles:180 Average:58158.95 Median:42240.29 stddev:109282.71 (258.7%) stddev-sans-first:109503.93 14:47:58 INFO - PROCESS | 11122 | Values: 634.4 636.7 640.9 653.1 657.2 32251.0 34942.3 43359.8 44875.8 44976.0 46464.5 46866.3 47010.0 47026.8 47123.0 8826.6 8952.9 8974.4 8974.4 8975.6 8906.0 8996.5 8997.6 9008.6 9009.1 8999.2 9007.1 9034.5 9049.8 9051.6 8930.8 8986.4 8994.9 8996.0 8999.7 8842.3 8848.0 8875.2 8889.7 8905.0 42929.0 43300.4 43312.1 43465.8 43843.6 3650.1 3741.9 3859.5 4029.8 4231.5 32346.0 33099.8 33450.0 33461.7 33478.5 4361.5 4421.9 4471.6 4521.9 4619.5 333681.0 334340.0 335620.0 336252.0 336857.0 57979.7 58379.7 58477.7 58536.0 58567.4 61777.0 62278.4 62325.7 62348.4 62408.0 17559.3 17729.6 17747.7 17777.7 17784.3 12305.6 12326.8 12336.4 12336.9 12359.4 15714.8 16938.2 16946.0 16958.6 16968.6 5235.0 6153.6 6162.1 6279.0 6317.6 952.5 996.0 1007.5 1078.5 1114.5 30823.8 32111.4 32376.4 32393.2 33253.5 1122.0 1172.0 1178.2 1178.3 1239.7 17373.9 17380.6 17456.5 17486.9 17634.2 496070.0 496185.0 499477.0 499776.0 500259.0 59701.1 59819.7 59857.4 59880.7 59929.4 1257.7 1302.4 1354.2 1386.3 1398.5 29827.9 34076.0 34130.3 34319.8 34383.3 50917.0 51006.0 51367.2 51485.0 51508.2 388295.0 391139.0 391805.0 392085.0 392568.0 36530.6 41164.8 42141.6 42200.6 42305.4 48351.3 49294.0 49588.0 49944.8 50400.0 40653.2 41575.8 41612.8 42257.6 42999.0 41063.0 41280.8 41305.2 41933.6 42223.0 40461.4 41012.8 41089.8 41868.2 41919.8 36485.3 36767.4 36987.3 37718.4 38117.6 28043.0 28124.9 28137.7 28151.0 28493.9 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#2] jquery.html Cycles:180 Average:28920.05 Median:31904.20 stddev:75706.03 (237.3%) stddev-sans-first:75888.06 14:47:58 INFO - PROCESS | 11122 | Values: 374.1 376.3 382.4 392.0 399.5 14711.9 14924.3 17368.3 20113.8 20272.5 17611.4 17953.6 18304.5 18657.0 18748.0 5593.5 5769.1 5800.6 5826.7 5829.1 3905.1 5390.5 5474.9 5650.1 5674.4 5626.5 5680.9 5681.2 5716.6 5735.1 5793.2 6157.2 6314.8 6361.0 6395.3 5504.1 5565.7 5603.7 5611.9 5636.7 13570.8 13690.8 13793.2 13796.7 16489.8 2346.2 2447.2 2609.8 2647.7 2894.8 14149.9 15502.8 15830.4 15896.0 16273.3 1914.0 1960.1 1999.9 2009.4 2040.2 76600.0 80682.8 87826.0 90704.0 93696.5 16374.4 17730.4 17872.6 17951.2 18138.7 31259.2 31847.2 31961.2 32026.7 32145.0 9813.2 9934.4 9957.5 10156.4 10181.0 7946.5 8184.3 8278.3 8369.9 8444.0 8606.9 8677.8 8891.5 9008.7 9105.3 2738.6 3018.6 3244.2 3453.7 3568.7 823.2 845.5 931.0 986.4 1085.4 18073.2 18679.9 19183.4 19420.6 19544.9 942.3 1006.7 1013.2 1023.4 1040.3 10371.0 10439.2 11023.4 11160.2 11547.4 370468.0 375305.0 500137.0 504406.0 505373.0 99903.5 101652.5 102726.5 105596.9 105986.0 998.7 1006.2 1040.4 1047.5 1053.4 16522.3 17033.2 17412.6 17638.2 17832.5 41482.0 41552.8 41919.0 42269.4 42752.4 58277.0 58399.7 59020.1 59498.7 59967.0 8338.1 8391.5 8484.8 8730.2 8735.0 8092.5 9305.8 10061.8 10881.5 11589.7 10299.2 10876.3 11097.7 11386.7 11493.6 10445.4 11144.4 11189.6 11312.7 11437.5 9043.6 11166.2 11330.4 11637.6 11646.6 8034.6 8058.4 8208.2 8315.3 8379.6 10492.6 11076.4 11393.7 11440.5 11527.1 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#3] mootools.html Cycles:180 Average:5734.28 Median:2370.85 stddev:3268.95 (137.9%) stddev-sans-first:3261.31 14:47:58 INFO - PROCESS | 11122 | Values: 1323.0 1460.6 1475.7 1608.8 1758.5 8060.3 8399.5 8412.2 8617.1 8618.4 8416.0 8572.9 8584.7 8585.8 8588.5 2020.8 2218.3 2274.2 2322.1 2354.6 2329.5 2335.0 2337.8 2338.2 2344.0 2258.2 2262.1 2290.7 2293.8 2295.1 1945.4 2229.1 2245.8 2314.7 2317.1 2277.4 2282.6 2283.2 2297.1 2302.0 8671.3 8715.2 8720.5 8730.5 8747.4 4977.3 5189.7 5192.4 5217.1 5238.9 3014.6 3157.5 3195.3 3238.1 3290.2 1036.3 1070.2 1088.6 1104.3 1108.5 11872.9 11894.5 11895.9 11896.5 11930.7 4550.8 4627.5 4649.7 4749.5 4755.5 10068.4 10082.4 10083.2 10084.5 10085.2 5037.4 5044.9 5047.1 5049.7 5050.3 4303.6 4699.8 4807.0 4840.2 4923.8 4017.5 4032.4 4095.4 4136.7 4145.5 1213.4 1233.3 1241.5 1253.3 1272.1 1011.1 1011.6 1017.9 1025.7 1026.1 6112.0 6191.3 6193.0 6195.4 6205.7 430.6 438.1 438.4 439.4 442.1 4139.8 4149.4 4213.6 4217.1 4239.5 10320.3 10605.4 10665.4 10668.6 10669.5 10475.0 10681.2 10684.4 10691.3 10711.2 7643.4 7888.1 8161.4 8231.2 8237.2 6090.4 6196.0 6284.5 6293.9 6418.5 9891.6 10125.2 10285.9 10313.1 10319.4 10407.6 10508.9 10521.2 10601.6 10604.6 7035.1 7714.5 7716.5 7888.4 7915.1 8407.8 8429.1 8474.0 8491.0 8504.4 7523.5 7609.2 7733.0 7808.6 7835.2 7533.4 7540.9 7598.1 7668.1 7772.3 6817.8 6849.5 6883.8 6895.2 6896.9 4959.2 5021.6 5102.1 5105.7 5173.9 5126.8 5198.6 5250.9 5364.3 5365.2 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#4] prototype.html Cycles:180 Average:4613.47 Median:5295.30 stddev:1357.22 (25.6%) stddev-sans-first:1322.38 14:47:58 INFO - PROCESS | 11122 | Values: 329.1 330.8 337.6 337.6 340.0 5281.3 5288.5 5291.8 5313.4 5329.0 5214.5 5219.6 5235.3 5273.5 5290.3 3935.5 3987.9 4144.5 4153.9 4165.3 4082.8 4095.4 4126.1 4141.4 4158.5 3903.2 4090.4 4091.1 4098.3 4121.6 3824.3 3888.7 4002.7 4135.5 4136.6 3632.0 3639.0 3675.5 3679.3 3684.0 5086.1 5094.6 5099.3 5117.6 5185.5 4472.4 4675.6 4686.9 4697.2 4704.8 5435.8 5444.2 5470.7 5477.5 5540.6 3979.5 3981.0 3996.7 4027.5 4058.8 5364.0 5625.9 5643.4 5679.5 5694.9 3931.9 3936.9 3939.3 3949.2 3976.8 3997.7 4005.5 4017.2 4022.5 4027.3 4437.8 4590.7 4600.4 4609.7 4636.7 5471.0 5478.4 5499.6 5504.7 5510.7 1374.0 1375.9 1401.5 1418.3 1420.9 843.8 891.6 898.2 901.8 909.7 5153.5 5225.2 5294.3 5301.0 5309.3 5568.2 5648.7 5665.8 5674.3 5679.1 5146.5 5293.0 5296.3 5326.4 5327.7 2948.7 2968.0 2975.8 2998.1 3009.7 5787.5 5801.1 5811.4 5824.1 5838.8 5479.5 5747.1 5751.4 5756.2 5773.3 5691.6 5737.8 5754.2 5756.8 5794.9 5283.9 5535.1 5541.2 5586.7 5596.9 5538.4 5545.3 5554.0 5561.7 5582.0 5771.0 5788.4 5794.7 5797.9 5812.5 3937.7 3998.7 4039.6 4045.5 4055.9 5549.6 5574.9 5599.5 5683.3 5709.3 5443.3 5458.6 5514.8 5521.9 5528.3 5228.8 5426.5 5469.2 5469.5 5485.0 5191.7 5374.2 5376.7 5439.4 5440.2 5326.8 5502.4 5509.5 5549.7 5573.6 5413.5 5414.9 5441.7 5444.2 5455.5 14:47:58 INFO - PROCESS | 11122 | 14:47:58 INFO - PROCESS | 11122 | [#5] yui.html Cycles:180 Average:19149.19 Median:47368.91 stddev:25839.78 (54.6%) stddev-sans-first:25875.29 14:47:58 INFO - PROCESS | 11122 | Values: 739.7 751.5 789.8 808.4 822.3 15623.7 15753.8 16169.1 16183.0 16677.5 15118.3 15172.5 15300.4 15346.5 15354.2 673.2 790.7 818.1 825.6 828.9 801.1 803.6 803.9 804.1 804.4 858.8 859.5 859.5 860.3 860.5 698.2 817.0 855.7 859.1 860.5 627.7 628.0 628.5 628.8 629.4 15015.2 15089.4 15097.8 15101.8 15115.0 13980.4 14232.4 14235.9 14250.9 14388.0 13216.8 13266.3 13315.7 13433.8 13943.5 4477.8 4515.1 4610.2 4623.4 4759.3 70177.6 70771.6 70919.0 71278.0 71773.6 11351.2 11355.3 11371.5 11433.0 11490.2 20922.9 20941.4 20953.0 20964.6 20987.1 8633.6 8703.1 8758.7 8842.5 9002.9 4784.8 4874.8 4880.3 4898.7 4931.1 3385.5 3484.4 3500.5 3535.3 3538.4 571.8 591.0 611.6 616.8 618.1 548.5 699.7 732.1 737.1 799.2 9727.1 10320.2 10357.2 10408.6 10479.8 603.9 644.5 673.4 673.6 763.9 4638.9 4707.5 4788.8 4806.4 4855.0 65374.7 101788.0 105753.5 106414.9 108558.0 58758.0 75202.0 89210.6 90147.5 92882.0 78528.6 80733.0 80928.6 81361.0 81949.6 8963.9 9034.1 9063.7 9319.7 9324.4 47131.5 47331.5 47525.0 47845.8 48295.0 47406.3 47426.0 48716.5 70853.6 71810.3 12606.0 12671.9 13055.9 13338.5 14118.6 14559.1 14756.3 15230.7 15395.2 16112.4 13826.5 13963.3 14356.8 14397.6 14914.3 14058.7 14333.9 14665.9 14667.3 15117.8 13673.8 14014.8 14219.2 14587.6 15046.8 11408.8 11483.1 11486.8 11538.7 12216.5 11323.6 11485.7 11892.1 12233.1 12275.3 14:47:58 INFO - PROCESS | 11122 | -------- Summary: end -------- 14:47:58 INFO - PROCESS | 11122 | 14:47:59 INFO - TEST-INFO | 11122: exit 0 14:47:59 INFO - TEST-OK | dromaeo_css | took 1114838ms 14:47:59 INFO - TEST-START | kraken 14:47:59 INFO - operating with platform_type : linux_ 14:47:59 INFO - Initialising browser for kraken test... 14:47:59 INFO - TEST-INFO | started process 11299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRO_IZ/profile http://localhost:50454/getInfo.html) 14:48:03 INFO - PROCESS | 11299 | __metrics Screen width/height:1600/1200 14:48:03 INFO - PROCESS | 11299 | colorDepth:24 14:48:03 INFO - PROCESS | 11299 | Browser inner width/height: 1024/697 14:48:03 INFO - PROCESS | 11299 | __metrics 14:48:05 ERROR - PROCESS | 11299 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:48:05 INFO - PROCESS | 11299 | console.error: PushService: 14:48:05 INFO - PROCESS | 11299 | stateChangeProcessEnqueue: Error transitioning state 14:48:05 INFO - PROCESS | 11299 | UnknownError 14:48:05 INFO - TEST-INFO | 11299: exit 0 14:48:05 INFO - Browser initialized. 14:48:05 INFO - Running cycle 1/1 for kraken test... 14:48:05 INFO - TEST-INFO | started process 11380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRO_IZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:17 INFO - PROCESS | 11380 | RSS: Main: 173658112 14:48:17 INFO - PROCESS | 11380 | 14:48:20 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:21 INFO - PROCESS | 11380 | RSS: Main: 231641088 14:48:21 INFO - PROCESS | 11380 | 14:48:23 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-dft) 14:48:24 INFO - PROCESS | 11380 | RSS: Main: 221368320 14:48:24 INFO - PROCESS | 11380 | 14:48:27 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-fft) 14:48:28 INFO - PROCESS | 11380 | RSS: Main: 286224384 14:48:28 INFO - PROCESS | 11380 | 14:48:30 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-oscillator) 14:48:31 INFO - PROCESS | 11380 | RSS: Main: 196476928 14:48:31 INFO - PROCESS | 11380 | 14:48:33 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:33 INFO - PROCESS | 11380 | RSS: Main: 200564736 14:48:33 INFO - PROCESS | 11380 | 14:48:36 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:37 INFO - PROCESS | 11380 | RSS: Main: 236503040 14:48:37 INFO - PROCESS | 11380 | 14:48:40 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:41 INFO - PROCESS | 11380 | RSS: Main: 232259584 14:48:41 INFO - PROCESS | 11380 | 14:48:44 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50454/tests/kraken/driver.html?testName=json-parse-financial) 14:48:44 INFO - PROCESS | 11380 | RSS: Main: 235384832 14:48:44 INFO - PROCESS | 11380 | 14:48:46 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:47 INFO - PROCESS | 11380 | RSS: Main: 223019008 14:48:47 INFO - PROCESS | 11380 | 14:48:48 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:49 INFO - PROCESS | 11380 | RSS: Main: 227700736 14:48:49 INFO - PROCESS | 11380 | 14:48:51 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:52 INFO - PROCESS | 11380 | RSS: Main: 234717184 14:48:52 INFO - PROCESS | 11380 | 14:48:54 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:55 INFO - PROCESS | 11380 | RSS: Main: 240095232 14:48:55 INFO - PROCESS | 11380 | 14:48:58 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:58 INFO - PROCESS | 11380 | RSS: Main: 240873472 14:48:58 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50454/tests/kraken/driver.html?testName=ai-astar) 14:49:00 INFO - PROCESS | 11380 | RSS: Main: 284008448 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | __start_tp_report 14:49:00 INFO - PROCESS | 11380 | _x_x_mozilla_page_load 14:49:00 INFO - PROCESS | 11380 | _x_x_mozilla_page_load_details 14:49:00 INFO - PROCESS | 11380 | |i|pagename|runs| 14:49:00 INFO - PROCESS | 11380 | |0;ai-astar;110;104;111;110;110;112;109;109;110;110 14:49:00 INFO - PROCESS | 11380 | |1;audio-beat-detection;159;124;133;177;130;137;156;124;159;125 14:49:00 INFO - PROCESS | 11380 | |2;audio-dft;161;160;161;162;161;162;161;161;161;160 14:49:00 INFO - PROCESS | 11380 | |3;audio-fft;74;75;75;155;77;76;76;75;116;74 14:49:00 INFO - PROCESS | 11380 | |4;audio-oscillator;84;85;121;85;86;88;126;85;86;129 14:49:00 INFO - PROCESS | 11380 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;117;117 14:49:00 INFO - PROCESS | 11380 | |6;imaging-darkroom;155;154;159;159;156;157;158;159;158;160 14:49:00 INFO - PROCESS | 11380 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;94 14:49:00 INFO - PROCESS | 11380 | |8;json-parse-financial;55;54;56;54;54;54;55;53;53;54 14:49:00 INFO - PROCESS | 11380 | |9;json-stringify-tinderbox;61;62;62;62;62;61;61;61;61;61 14:49:00 INFO - PROCESS | 11380 | |10;stanford-crypto-aes;84;86;80;84;80;81;81;80;123;80 14:49:00 INFO - PROCESS | 11380 | |11;stanford-crypto-ccm;124;126;136;120;122;131;131;123;145;131 14:49:00 INFO - PROCESS | 11380 | |12;stanford-crypto-pbkdf2;161;163;163;165;162;166;163;161;159;161 14:49:00 INFO - PROCESS | 11380 | |13;stanford-crypto-sha256-iterative;65;63;63;66;65;65;63;64;64;66 14:49:00 INFO - PROCESS | 11380 | __end_tp_report 14:49:00 INFO - PROCESS | 11380 | __start_cc_report 14:49:00 INFO - PROCESS | 11380 | _x_x_mozilla_cycle_collect,1626 14:49:00 INFO - PROCESS | 11380 | __end_cc_report 14:49:00 INFO - PROCESS | 11380 | __startTimestamp1465508940590__endTimestamp 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | ------- Summary: start ------- 14:49:00 INFO - PROCESS | 11380 | Number of tests: 14 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 14:49:00 INFO - PROCESS | 11380 | Values: 110.0 104.0 111.0 110.0 110.0 112.0 109.0 109.0 110.0 110.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:146.50 stddev:18.81 (12.8%) stddev-sans-first:18.97 14:49:00 INFO - PROCESS | 11380 | Values: 159.0 124.0 133.0 177.0 130.0 137.0 156.0 124.0 159.0 125.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 14:49:00 INFO - PROCESS | 11380 | Values: 161.0 160.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 160.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.00 stddev:27.03 (36.0%) stddev-sans-first:28.24 14:49:00 INFO - PROCESS | 11380 | Values: 74.0 75.0 75.0 155.0 77.0 76.0 76.0 75.0 116.0 74.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:19.33 (22.7%) stddev-sans-first:19.87 14:49:00 INFO - PROCESS | 11380 | Values: 84.0 85.0 121.0 85.0 86.0 88.0 126.0 85.0 86.0 129.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:49:00 INFO - PROCESS | 11380 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#6] imaging-darkroom Cycles:10 Average:157.50 Median:158.50 stddev:1.96 (1.2%) stddev-sans-first:1.86 14:49:00 INFO - PROCESS | 11380 | Values: 155.0 154.0 159.0 159.0 156.0 157.0 158.0 159.0 158.0 160.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:49:00 INFO - PROCESS | 11380 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 14:49:00 INFO - PROCESS | 11380 | Values: 55.0 54.0 56.0 54.0 54.0 54.0 55.0 53.0 53.0 54.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:49:00 INFO - PROCESS | 11380 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:81.00 stddev:13.21 (16.3%) stddev-sans-first:14.00 14:49:00 INFO - PROCESS | 11380 | Values: 84.0 86.0 80.0 84.0 80.0 81.0 81.0 80.0 123.0 80.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.00 stddev:7.58 (5.8%) stddev-sans-first:7.83 14:49:00 INFO - PROCESS | 11380 | Values: 124.0 126.0 136.0 120.0 122.0 131.0 131.0 123.0 145.0 131.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:2.07 (1.3%) stddev-sans-first:2.13 14:49:00 INFO - PROCESS | 11380 | Values: 161.0 163.0 163.0 165.0 162.0 166.0 163.0 161.0 159.0 161.0 14:49:00 INFO - PROCESS | 11380 | 14:49:00 INFO - PROCESS | 11380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.17 (1.8%) stddev-sans-first:1.22 14:49:00 INFO - PROCESS | 11380 | Values: 65.0 63.0 63.0 66.0 65.0 65.0 63.0 64.0 64.0 66.0 14:49:00 INFO - PROCESS | 11380 | -------- Summary: end -------- 14:49:00 INFO - PROCESS | 11380 | 14:49:01 INFO - TEST-INFO | 11380: exit 0 14:49:01 INFO - TEST-OK | kraken | took 62066ms 14:49:01 INFO - SUITE-END | took 1176s 14:49:01 INFO - Completed test suite (00:19:37) 14:49:01 INFO - javascript benchmark 14:49:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.9238019049526, 3051.2760290435904, 3072.5237588173813, 3074.523448865426, 3111.0355789705177, 5270.156774916014, 5276.788928442863, 5325.7869685212545, 5342.465753424665, 5349.438308977559, 5346.91979620306, 5352.57179425646, 5360.865978350544, 5366.382865970415, 5427.782888684448, 4769.833055843046, 4878.609711223111, 4882.902341953159, 4904.926426103593, 5044.4955504449445, 4906.533879281463, 4947.109520286347, 4981.825636102737, 5011.373578302712, 5013.724245166514, 4732.077244937239, 4741.786619602091, 4788.545088216596, 4838.491958344358, 4841.080194763019, 4782.641301902337, 4783.425988881357, 4791.808327666924, 4798.49615790344, 4881.511848815126, 4771.785269662873, 4781.0676918001, 4810.927836082462, 4812.1578723723205, 4834.613230941552, 5167.741612919376, 5271.525562699376, 5369.4630536946, 5376.838694839161, 5377.381601115882, 5795.420457954213, 5796.1305804129715, 5813.447722466359, 5821.27234095738, 5827.125931110325, 5862.384449632812, 5870.501007414375, 5889.705514724246, 5891.941080589225, 5898.646081235097, 5243.475652434726, 5323.30796996388, 5384.16545435462, 5385.407605163429, 5450.373207081237, 5921.259842519685, 5922.763089476459, 5928.347881733006, 5928.822135335947, 5929.881402371929, 5569.66582005081, 5633.211350410946, 5678.545716342683, 5679.31848178213, 5684.8294551163535, 5658.094704847204, 5750.367459579443, 5755.906377788207, 5784.595078344475, 5787.247657804459, 5748.511376532958, 5758.62568933018, 5762.88474230513, 5764.0, 5767.596268261182, 5539.390667026624, 5661.773529058792, 5752.712364381764, 5760.971195143998, 5766.596338256281, 4365.781710914442, 4372.344148377705, 4395.1429471252795, 4432.180046691373, 4439.9778001110435, 3886.378179491268, 3900.902477438087, 3919.784411857318, 3920.5491368492417, 3951.229510245532, 5339.492748188916, 5339.599530035263, 5429.972850135724, 5462.317210348707, 5502.394736578973, 5779.971100144472, 5793.768249270066, 5818.8254352369495, 5839.562032847553, 5866.970665146732, 5489.807856725075, 5505.091659876076, 5506.03644362235, 5509.889802204014, 5515.172724091419, 4906.1414252505665, 4946.208606622923, 4962.727050012212, 4976.601871850244, 5031.547160755549, 5950.9702451487465, 5957.046872500379, 5957.553183511254, 5988.401159883977, 5996.580239383288, 5809.390014048633, 5824.0, 5824.213731146241, 5825.41745825431, 5826.533877289722, 5781.4218578141845, 5923.614965027259, 5964.940350596438, 5970.701464926823, 5975.043992961106, 5755.913661295168, 5760.0783874579865, 5763.135529670583, 5765.740541675718, 5766.163906233656, 5814.709264536841, 5870.706464676835, 5872.119182122716, 5880.059190529495, 5880.941190588211, 5557.36090349615, 5559.63862348946, 5569.387367389503, 5601.943980560142, 5620.522255608319, 5548.639338442988, 5582.106862901916, 5606.85982850432, 5610.915836262541, 5615.045442274742, 5362.946370536245, 5507.03626865305, 5519.199716041232, 5523.254360661259, 5566.721663916869, 5641.915371269516, 5671.206031155559, 5679.034564124191, 5773.393793651606, 5773.8556536086935, 5590.720463976866, 5600.047991841316, 5605.299337582802, 5606.2431571738925, 5651.124075768263], "value": 5305.073180508901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.3656343656344, 636.6848410037031, 640.8654182621649, 653.1476423267637, 657.2113463843383, 32251.0, 34942.30115397691, 43359.78320108395, 44875.77562112185, 44976.0, 46464.53535464653, 46866.29700554494, 47010.0, 47026.764866175705, 47123.0, 8826.558672066387, 8952.8657070144, 8974.371793974424, 8974.41666291689, 8975.640974361018, 8905.955470222672, 8996.505192214425, 8997.595108220146, 9008.59461324242, 9009.099090091004, 8999.190072893438, 9007.144321289466, 9034.457932524037, 9049.773755656128, 9051.637934482613, 8930.776730581754, 8986.415882967585, 8994.86507702385, 8996.0, 8999.730008099768, 8842.292616590657, 8848.0, 8875.156860098345, 8889.688860889903, 8905.020447750741, 42929.0, 43300.35049474229, 43312.13375732468, 43465.78267108676, 43843.56156438427, 3650.0509867434394, 3741.8877433677035, 3859.4982652255026, 4029.8186581603604, 4231.513375961742, 32346.0, 33099.83450082758, 33449.99650010504, 33461.665383346095, 33478.497822532685, 4361.454818147731, 4421.9115617687785, 4471.6199123074575, 4521.864344069683, 4619.514950930171, 333681.0, 334340.0, 335620.0, 336252.0, 336857.0, 57979.71010144922, 58379.70810145922, 58477.70761146167, 58536.0, 58567.414325856196, 61777.0, 62278.37721622817, 62325.68837155785, 62348.37651623516, 62408.0, 17559.297628094733, 17729.645407091786, 17747.73378399325, 17777.733334, 17784.288628454717, 12305.630831075083, 12326.75346493065, 12336.444859981322, 12336.876631233752, 12359.38203089842, 15714.842851571566, 16938.153092345332, 16946.0, 16958.57603559921, 16968.57578560546, 5235.0, 6153.569250152446, 6162.137300777895, 6279.0, 6317.557770956081, 952.4808979106404, 995.9800803983879, 1007.496251874063, 1078.541619811577, 1114.4817659788237, 30823.8458807709, 32111.35777284441, 32376.35247295041, 32393.19017024546, 33253.50119748206, 1121.966341009771, 1171.9707007324714, 1178.157617303632, 1178.2871362825367, 1239.6590937492263, 17373.913130434266, 17380.62336864733, 17456.47630571085, 17486.912565437346, 17634.206460709298, 496070.0, 496185.0, 499477.0, 499776.0, 500259.0, 59701.104483432784, 59819.700901496086, 59857.401425986056, 59880.70059649674, 59929.40070599238, 1257.6604316834403, 1302.426932149851, 1354.1536539662711, 1386.2791348498724, 1398.5454727213696, 29827.91776531062, 34076.0, 34130.31739365248, 34319.828400857834, 34383.31233375368, 50917.0, 51006.0, 51367.22949155691, 51485.0, 51508.227376588635, 388295.0, 391139.0, 391805.0, 392085.0, 392568.0, 36530.63469365379, 41164.794176030126, 42141.57858421376, 42200.57799421967, 42305.365419519345, 48351.27473087977, 49294.0, 49588.0, 49944.750276248385, 50400.0, 40653.1509038255, 41575.7921210392, 41612.79193604013, 42257.57742422659, 42999.0, 41063.0, 41280.79359603183, 41305.1738965213, 41933.58066419297, 42223.0, 40461.393079104426, 41012.79493602513, 41089.79455102705, 41868.23185913282, 41919.79040104902, 36485.27029459449, 36767.448488273236, 36987.26025479529, 37718.43422348612, 38117.618823811405, 28042.964790244438, 28124.890877618247, 28137.71720173158, 28150.961782267874, 28493.930765772184], "value": 20364.031524600872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1021548284117, 376.28130271182033, 382.42826973674363, 391.9686425085993, 399.50062421972535, 14711.852881471183, 14924.253787310645, 17368.30526778929, 20113.798862011376, 20272.493187670298, 17611.383601573947, 17953.64092718145, 18304.542386440346, 18657.0, 18748.0, 5593.496585307312, 5769.1346298055205, 5800.564957628174, 5826.737796799133, 5829.067349224125, 3905.082305658168, 5390.487903649167, 5474.863128421782, 5650.0959846424585, 5674.375818659944, 5626.54987600993, 5680.886382272352, 5681.233033540481, 5716.599838011341, 5735.053716136832, 5793.246877905866, 6157.199564056688, 6314.778982735582, 6361.0, 6395.296517383107, 5504.0643090674685, 5565.749541270652, 5603.691796951166, 5611.915821262684, 5636.71816409182, 13570.796438053438, 13690.794638080437, 13793.172409655454, 13796.689314515104, 16489.752653710202, 2346.248846086688, 2447.229122826304, 2609.8042646801377, 2647.7352264773367, 2894.8263104213815, 14149.929250353785, 15502.767458488019, 15830.366785328573, 15896.046237225804, 16273.291304413104, 1913.9808601913942, 1960.1179469238757, 1999.8900060496667, 2009.4072248686673, 2040.1737296394983, 76600.0, 80682.78975815309, 87826.0, 90704.0, 93696.53151734266, 16374.426895058616, 17730.404263616336, 17872.642547148986, 17951.192196351196, 18138.72791908096, 31259.218519537193, 31847.203819904225, 31961.20096997547, 32026.67973320237, 32145.0, 9813.214942804558, 9934.354266972623, 9957.452340121363, 10156.39061656303, 10181.0, 7946.523208607502, 8184.304334131546, 8278.337732981347, 8369.916300836914, 8443.957780211182, 8606.87089693655, 8677.783055423664, 8891.4665120093, 9008.684696035738, 9105.317101217302, 2738.561830107173, 3018.5623084652602, 3244.2051697334305, 3453.723702103826, 3568.7323450741296, 823.189158678701, 845.4842546046906, 931.0240770147898, 986.3539381704994, 1085.403028334413, 18073.186706598233, 18679.90660046691, 19183.424497265103, 19420.61158776845, 19544.90227548853, 942.330945029037, 1006.6979906028163, 1013.2299452416216, 1023.3552861697232, 1040.2718097331897, 10371.0, 10439.217058720626, 11023.393713345842, 11160.218784684994, 11547.422628868522, 370468.0, 375305.0, 500137.0, 504406.0, 505373.0, 99903.50048249713, 101652.49173754084, 102726.48636756917, 105596.94403056025, 105986.0, 998.650472334677, 1006.2201793610011, 1040.3601784902382, 1047.4710271312938, 1053.3521884041259, 16522.339106435607, 17033.233504492575, 17412.564685882953, 17638.206280717655, 17832.465026049238, 41481.96295092647, 41552.79223603863, 41919.0, 42269.36595951002, 42752.358714618684, 58277.0, 58399.70800146142, 59020.11469828042, 59498.70250648719, 59967.0, 8338.124496927978, 8391.454555453876, 8484.830303394021, 8730.214280714767, 8735.039145693841, 8092.514449133071, 9305.813883722152, 10061.798764024825, 10881.510332034919, 11589.6523104307, 10299.176065914859, 10876.347419154876, 11097.667069987914, 11386.658400248005, 11493.597724079616, 10445.425501597485, 11144.442777860912, 11189.608363707232, 11312.717182070184, 11437.485313160762, 9043.638254469748, 11166.218364714392, 11330.37682927447, 11637.592684256011, 11646.592369267035, 8034.598270086589, 8058.395620328616, 8208.179182081743, 8315.293200078062, 8379.58102094905, 10492.580296788043, 11076.446177691245, 11393.658190254306, 11440.48517816717, 11527.135464840003], "value": 9744.927964686573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.9603111906647, 1460.6129375715434, 1475.712236113958, 1608.790857188566, 1758.4724582625217, 8060.274575288223, 8399.49603023819, 8412.200840920119, 8617.138286171396, 8618.439801412904, 8415.95792021039, 8572.914270857289, 8584.656613735444, 8585.828283434328, 8588.527630980308, 2020.75750909891, 2218.3123231798113, 2274.169927976285, 2322.094383190553, 2354.576176288276, 2329.522447898177, 2334.9883250583725, 2337.754535773745, 2338.205010296499, 2344.0272287000957, 2258.2096266306744, 2262.061244583496, 2290.7365652949875, 2293.7591552886956, 2295.0819672131115, 1945.4455480188149, 2229.0860747093693, 2245.831562632809, 2314.710661167354, 2317.073170731704, 2277.39648993017, 2282.600544904635, 2283.2122917593406, 2297.0696867768415, 2302.044651469638, 8671.262942649882, 8715.215630593277, 8720.476771393736, 8730.476171429671, 8747.387682862201, 4977.303177555145, 5189.740512974374, 5192.3769147702515, 5217.139172036609, 5238.869028274324, 3014.608100946863, 3157.542156387311, 3195.328980914011, 3238.077148012805, 3290.177455636091, 1036.2953191829554, 1070.2294348069456, 1088.6135421925183, 1104.265663333882, 1108.4956344863149, 11872.881271187263, 11894.52421903123, 11895.94052029743, 11896.464659090361, 11930.701732456671, 4550.817967281272, 4627.514111018362, 4649.674522783373, 4749.501302363202, 4755.548222918817, 10068.44623545712, 10082.445465499468, 10083.243756718275, 10084.546195421224, 10085.243606729524, 5037.4458809530925, 5044.924326135111, 5047.066292735783, 5049.747512624354, 5050.267711181858, 4303.63419109373, 4699.812007519661, 4807.038592281558, 4840.177169881129, 4923.77842997066, 4017.5379831319187, 4032.403415705826, 4095.385692146202, 4136.689748268892, 4145.481814773153, 1213.4296880466168, 1233.2600439736086, 1241.4971936365787, 1253.3169422664669, 1272.0650322013498, 1011.079917275276, 1011.6307547745167, 1017.8524114003576, 1025.7230547752215, 1026.0509029148157, 6112.0, 6191.349908259568, 6193.0, 6195.411435913581, 6205.720742566596, 430.5651292194906, 438.07128886759637, 438.4475560793359, 439.3760859579405, 442.06723812755064, 4139.793010349531, 4149.419081328617, 4213.557576454489, 4217.051163488252, 4239.491261048694, 10320.329178603517, 10605.363678179334, 10665.41340226295, 10668.62659806903, 10669.466526673636, 10475.0, 10681.198910081775, 10684.358938463716, 10691.30506517074, 10711.196660250513, 7643.388528917784, 7888.1323054463965, 8161.428699991063, 8231.218034286732, 8237.176282371835, 6090.421409966046, 6196.0, 6284.528660350584, 6293.937060629335, 6418.4865210783955, 9891.604335826487, 10125.240606954361, 10285.9485702571, 10313.1233845124, 10319.380837149494, 10407.635732749317, 10508.947455262674, 10521.21090918169, 10601.575936962743, 10604.575816967543, 7035.12060992376, 7714.459987801025, 7716.5370077795515, 7888.3689304856625, 7915.129335773176, 8407.789805254917, 8429.072801991653, 8473.95763021181, 8491.023532293866, 8504.362172836938, 7523.473356865185, 7609.239076092346, 7732.961335193288, 7808.609569521387, 7835.216478352119, 7533.39732821362, 7540.886886696594, 7598.0502437195355, 7668.079830420385, 7772.339351155215, 6817.761378351734, 6849.452043836382, 6883.793486195422, 6895.207051189177, 6896.862062758817, 4959.156943319572, 5021.648484606042, 5102.056119617882, 5105.744712764273, 5173.870653233699, 5126.820561280338, 5198.558122559625, 5250.947490525045, 5364.329458817648, 5365.168398898177], "value": 4504.642625930109, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.12945259787864, 330.7502835359304, 337.6404129601973, 337.64547225413327, 340.02413074476254, 5281.287026251455, 5288.471152884715, 5291.841244762659, 5313.362396512424, 5328.999999999995, 5214.452482489341, 5219.556337711299, 5235.267062611238, 5273.525382715555, 5290.285811415458, 3935.5277366716036, 3987.940180897289, 4144.5340022686605, 4153.940745109992, 4165.33354663254, 4082.7754473503946, 4095.4266402703647, 4126.112885729567, 4141.420201171838, 4158.521769996444, 3903.2193561287713, 4090.365993271033, 4091.1204091120403, 4098.262312783698, 4121.629053385194, 3824.349860523718, 3888.727789054753, 4002.6777774447282, 4135.462389889325, 4136.648384887289, 3632.0, 3638.981805090984, 3675.46705727668, 3679.2825399047197, 3683.9815800920824, 5086.059079070384, 5094.59243260542, 5099.3228555008545, 5117.590592752571, 5185.5333020028, 4472.396226509412, 4675.602573781232, 4686.906261874743, 4697.201475749131, 4704.753240391299, 5435.809746658888, 5444.210589464506, 5470.699111548864, 5477.507024367826, 5540.639858409231, 3979.522457305142, 3980.960190398088, 3996.72022958393, 4027.456293400412, 4058.7767672777986, 5364.0, 5625.887482250373, 5643.407442218549, 5679.545636349124, 5694.914576281318, 3931.941020884689, 3936.901577460529, 3939.2909276330533, 3949.2101579684177, 3976.7812770297332, 3997.6601988830694, 4005.4592629994577, 4017.176478821893, 4022.517297924268, 4027.2549578328103, 4437.755923424178, 4590.747508887043, 4600.35595016698, 4609.700369475973, 4636.72490065228, 5470.972645136749, 5478.369987451414, 5499.642523235977, 5504.697241651747, 5510.669359838343, 1373.979390309146, 1375.8624137586362, 1401.509471684902, 1418.3121186224673, 1420.8792252658434, 843.767963809945, 891.6210610490516, 898.1961144775389, 901.783571942729, 909.6997990663066, 5153.5361817436615, 5225.190095535198, 5294.338207724035, 5300.959130734618, 5309.256704061435, 5568.248286481355, 5648.71756412186, 5665.830025099253, 5674.290713660793, 5679.091345384719, 5146.485351464824, 5293.0, 5296.25852380667, 5326.360836699543, 5327.653702509402, 2948.7442106788326, 2968.0, 2975.8363290018824, 2998.130542142798, 3009.714077162666, 5787.536997040227, 5801.12983052537, 5811.4479124483105, 5824.126381042793, 5838.766449341979, 5479.479449452296, 5747.08046712524, 5751.396103409082, 5756.194132821408, 5773.29687742117, 5691.60555663865, 5737.790950484094, 5754.1944127822135, 5756.798512052225, 5794.870000349892, 5283.947160528345, 5535.086710692852, 5541.224228608079, 5586.748596313095, 5596.944030559643, 5538.418466061005, 5545.279113715191, 5554.0, 5561.749721262472, 5581.972090139523, 5771.0, 5788.37925380894, 5794.710264486843, 5797.884042319046, 5812.476877081083, 3937.724359294822, 3998.740081894784, 4039.5556488785624, 4045.453863728477, 4055.878323650295, 5549.639273447213, 5574.888502230014, 5599.524040456607, 5683.323419591148, 5709.286339207599, 5443.292371991774, 5458.608054945963, 5514.80698175562, 5521.917171242515, 5528.281323427928, 5228.816991405282, 5426.511613954763, 5469.179623056573, 5469.507744302873, 5485.0, 5191.6884986900905, 5374.226505253179, 5376.677399356051, 5439.4288599696465, 5440.211169380497, 5326.840194794162, 5502.367227768857, 5509.47659972302, 5549.722513874371, 5573.6098473106495, 5413.458654134713, 5414.918776218438, 5441.727913604224, 5444.156155795858, 5455.454454554513], "value": 4179.326408574314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7336958694872, 751.5302935665209, 789.7630710786763, 808.385626923538, 822.3462347433791, 15623.687526249483, 15753.763693544577, 16169.11069891157, 16183.0, 16677.49967500977, 15118.319675614597, 15172.468963586276, 15300.387984480607, 15346.462873799419, 15354.232288385563, 673.1652750589259, 790.6600161930368, 818.136865606786, 825.5789547330875, 828.8590939540293, 801.1067659559578, 803.5982008995502, 803.8834369016489, 804.0512195609178, 804.4368941740776, 858.7509622209552, 859.4628357276702, 859.4757198109148, 860.3031544449017, 860.5310105992249, 698.2389195776602, 817.0318172965056, 855.670566831768, 859.0764927702683, 860.5310105992249, 627.6641996531833, 627.9560430769848, 628.5160426471591, 628.8302158417201, 629.3549112160073, 15015.249237538079, 15089.39642414302, 15097.773533397009, 15101.848981510155, 15115.0, 13980.370883310276, 14232.430702771877, 14235.857641423558, 14250.857491425057, 14388.0, 13216.801747973788, 13266.3366831659, 13315.733685326337, 13433.798493022612, 13943.511977080754, 4477.843275485375, 4515.096980603859, 4610.216263235258, 4623.445186577598, 4759.286107083931, 70177.64911175462, 70771.64614176948, 70919.0, 71278.0, 71773.64113179401, 11351.212169228227, 11355.318680879174, 11371.54513819438, 11433.017484042362, 11490.199008692553, 20922.895385522974, 20941.371758847257, 20953.0, 20964.580708385747, 20987.055582498826, 8633.568321583896, 8703.129687031373, 8758.737237882873, 8842.513661748537, 9002.909970900208, 4784.832530861403, 4874.8050077997195, 4880.267959805987, 4898.657094003385, 4931.112399768076, 3385.509101180315, 3484.3902317094407, 3500.5274287971306, 3535.292941411728, 3538.398472259722, 571.8313097636208, 590.9822705318848, 611.5535658968978, 616.7594638091148, 618.1191801682585, 548.4542879834511, 699.6711545573572, 732.1264038648391, 737.1449119021909, 799.1848314718954, 9727.124558789743, 10320.225983051301, 10357.171426285879, 10408.583656653649, 10479.84280235797, 603.9003564411911, 644.4511955217198, 673.4040374268808, 673.6160388578463, 763.9313157202005, 4638.907221855611, 4707.481497398875, 4788.767457492068, 4806.351142595705, 4854.997410668, 65374.673126634065, 101788.0, 105753.47123264335, 106414.86420962604, 108558.0, 58758.0, 75202.0, 89210.55394723115, 90147.54926225326, 92882.0, 78528.60735696285, 80733.0, 80928.59535702284, 81360.99999999882, 81949.59025204837, 8963.910360896307, 9034.096590340914, 9063.68277110298, 9319.673811416567, 9324.440533568008, 47131.52868471271, 47331.526684732715, 47525.0, 47845.76077119731, 48295.0, 47406.28890566575, 47426.0, 48716.512834872614, 70853.64573177102, 71810.28189718245, 12606.0, 12671.936640316739, 13055.869441305465, 13338.533151339656, 14118.576442706735, 14559.12645241289, 14756.335964881391, 15230.695386091995, 15395.153266570445, 16112.436064737678, 13826.516071937434, 13963.301834908418, 14356.784648230076, 14397.64005899861, 14914.328855201325, 14058.718825623635, 14333.928330358282, 14665.853341466876, 14667.266636667911, 15117.848821511645, 13673.79489307681, 14014.78977815354, 14219.21794301282, 14587.635309116933, 15046.849531504546, 11408.771824563297, 11483.138764592855, 11486.827697584376, 11538.653840384803, 12216.511339546318, 11323.603673871376, 11485.712857178303, 11892.122947234235, 12233.143679942319, 12275.263484190977], "value": 7508.218999562832, "unit": "score"}], "name": "dromaeo_css", "value": 7279.71231253775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 110.0, 110.0, 112.0, 109.0, 109.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 133.0, 177.0, 130.0, 137.0, 156.0, 124.0, 159.0, 125.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 155.0, 77.0, 76.0, 76.0, 75.0, 116.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 85.0, 86.0, 88.0, 126.0, 85.0, 86.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 159.0, 159.0, 156.0, 157.0, 158.0, 159.0, 158.0, 160.0], "value": 157.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 80.0, 84.0, 80.0, 81.0, 81.0, 80.0, 123.0, 80.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 136.0, 120.0, 122.0, 131.0, 131.0, 123.0, 145.0, 131.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 165.0, 162.0, 166.0, 163.0, 161.0, 159.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 66.0, 65.0, 65.0, 63.0, 64.0, 64.0, 66.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1523.8000000000006, "alertThreshold": 2.0}]} 14:49:01 INFO - Return code: 0 14:49:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:49:01 ERROR - # TBPL SUCCESS # 14:49:01 INFO - Running post-action listener: _resource_record_post_action 14:49:01 INFO - ##### 14:49:01 INFO - ##### Finished run-tests step (success) 14:49:01 INFO - ##### 14:49:01 INFO - Running post-run listener: _resource_record_post_run 14:49:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551096320; Read time: 20; Write time: 594064 14:49:01 INFO - TinderboxPrint: CPU usage
13.2% 14:49:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:49:01 INFO - TinderboxPrint: I/O write bytes / time
551,096,320 / 594,064 14:49:01 INFO - TinderboxPrint: CPU idle
8,275.6 (86.8%) 14:49:01 INFO - TinderboxPrint: CPU user
1,209.3 (12.7%) 14:49:01 INFO - TinderboxPrint: Swap in / out
0 / 0 14:49:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243265536; Read time: 0; Write time: 276360 14:49:01 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291676160; Read time: 20; Write time: 315348 14:49:02 INFO - Running post-run listener: _upload_blobber_files 14:49:02 INFO - Blob upload gear active. 14:49:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:49:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:49:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:49:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:49:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:03 INFO - (blobuploader) - INFO - Done attempting. 14:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:04 INFO - (blobuploader) - INFO - Done attempting. 14:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:08 INFO - (blobuploader) - INFO - Done attempting. 14:49:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:08 INFO - Return code: 0 14:49:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/022eec5b7c8b30a98f340034ec5fde96fd6c4a48493fb4a84de3dd39d2ffbd2b1630c8af96218faa389517fcc05249e054db64671509d7af1a1c8287e843adab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbd21b7a7dad2d28282365a1a910d755a3df4855f9de9fd2692f150afcb986847611e0d91ab6bf5141063fd383ce446eb666a2cb73ece55d3bb8aee7fc6b9960", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9dd17455c1b46d851769d8795f38994c99d6585eb39cc8e7f647b1cb9c3361fc17571c81386175cf8b9dbdce314bc40dbea6fc6313c4d37e6ff0ff41a3a44cf"} 14:49:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:08 INFO - Contents: 14:49:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/022eec5b7c8b30a98f340034ec5fde96fd6c4a48493fb4a84de3dd39d2ffbd2b1630c8af96218faa389517fcc05249e054db64671509d7af1a1c8287e843adab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbd21b7a7dad2d28282365a1a910d755a3df4855f9de9fd2692f150afcb986847611e0d91ab6bf5141063fd383ce446eb666a2cb73ece55d3bb8aee7fc6b9960", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9dd17455c1b46d851769d8795f38994c99d6585eb39cc8e7f647b1cb9c3361fc17571c81386175cf8b9dbdce314bc40dbea6fc6313c4d37e6ff0ff41a3a44cf"} 14:49:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:08 INFO - Copying logs to upload dir... 14:49:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.490813 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 14:49:08.300631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:49:08.303662) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/022eec5b7c8b30a98f340034ec5fde96fd6c4a48493fb4a84de3dd39d2ffbd2b1630c8af96218faa389517fcc05249e054db64671509d7af1a1c8287e843adab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbd21b7a7dad2d28282365a1a910d755a3df4855f9de9fd2692f150afcb986847611e0d91ab6bf5141063fd383ce446eb666a2cb73ece55d3bb8aee7fc6b9960", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9dd17455c1b46d851769d8795f38994c99d6585eb39cc8e7f647b1cb9c3361fc17571c81386175cf8b9dbdce314bc40dbea6fc6313c4d37e6ff0ff41a3a44cf"} build_url:https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/022eec5b7c8b30a98f340034ec5fde96fd6c4a48493fb4a84de3dd39d2ffbd2b1630c8af96218faa389517fcc05249e054db64671509d7af1a1c8287e843adab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbd21b7a7dad2d28282365a1a910d755a3df4855f9de9fd2692f150afcb986847611e0d91ab6bf5141063fd383ce446eb666a2cb73ece55d3bb8aee7fc6b9960", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9dd17455c1b46d851769d8795f38994c99d6585eb39cc8e7f647b1cb9c3361fc17571c81386175cf8b9dbdce314bc40dbea6fc6313c4d37e6ff0ff41a3a44cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:49:08.328782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:49:08.329107) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465507708.177709-198712990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:49:08.416783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:49:08.417123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:49:08.417430) ========= ========= Total master_lag: 0.17 =========