builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1466602937.19 results: success (0) buildid: 20160622060501 builduid: e6e98a69332c483f8bf3d9ae1dcb126f revision: 7687a980146e848a1c33ddc606d35fb046081ed8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.190541) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.191048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.191349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.219314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.219676) ========= 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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 06:42:17-- 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% 70.6M=0s 2016-06-22 06:42:17 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.347729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.348045) ========= 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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017292 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:17.398004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 06:42:17.398421) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7687a980146e848a1c33ddc606d35fb046081ed8 --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 7687a980146e848a1c33ddc606d35fb046081ed8 --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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 06:42:17,392 truncating revision to first 12 chars 2016-06-22 06:42:17,392 Setting DEBUG logging. 2016-06-22 06:42:17,392 attempt 1/10 2016-06-22 06:42:17,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7687a980146e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 06:42:18,687 unpacking tar archive at: fx-team-7687a980146e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.633808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 06:42:19.045438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:19.045815) ========= script_repo_revision: 7687a980146e848a1c33ddc606d35fb046081ed8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:19.046229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:19.046545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 06:42:19.056822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-22 06:42:19.057122) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:42:19 INFO - MultiFileLogger online at 20160622 06:42:19 in /builds/slave/test 06:42:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:42:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:19 INFO - {'append_to_log': False, 06:42:19 INFO - 'base_work_dir': '/builds/slave/test', 06:42:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:42:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:19 INFO - 'branch': 'Fx-Team-Non-PGO', 06:42:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:19 INFO - 'config_files': ('talos/linux_config.py',), 06:42:19 INFO - 'default_actions': ('clobber', 06:42:19 INFO - 'read-buildbot-config', 06:42:19 INFO - 'download-and-extract', 06:42:19 INFO - 'populate-webroot', 06:42:19 INFO - 'create-virtualenv', 06:42:19 INFO - 'install', 06:42:19 INFO - 'run-tests'), 06:42:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:19 INFO - 'download_minidump_stackwalk': True, 06:42:19 INFO - 'download_symbols': 'ondemand', 06:42:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:19 INFO - 'installer_path': 'installer.exe', 06:42:19 INFO - 'log_level': 'info', 06:42:19 INFO - 'log_name': 'talos', 06:42:19 INFO - 'log_to_console': True, 06:42:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:42:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:42:19 INFO - 'opt_config_files': (), 06:42:19 INFO - 'pip_index': False, 06:42:19 INFO - 'sps_profile': False, 06:42:19 INFO - 'sps_profile_interval': 0, 06:42:19 INFO - 'suite': 'dromaeojs-e10s', 06:42:19 INFO - 'system_bits': '32', 06:42:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:19 INFO - 'title': 'talos-linux64-ix-038', 06:42:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:19 INFO - 'use_talos_json': True, 06:42:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:19 INFO - 'work_dir': 'build'} 06:42:19 INFO - ##### 06:42:19 INFO - ##### Running clobber step. 06:42:19 INFO - ##### 06:42:19 INFO - Running pre-action listener: _resource_record_pre_action 06:42:19 INFO - Running main action method: clobber 06:42:19 INFO - rmtree: /builds/slave/test/build 06:42:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:19 INFO - Running post-action listener: _resource_record_post_action 06:42:19 INFO - ##### 06:42:19 INFO - ##### Finished clobber step (success) 06:42:19 INFO - ##### 06:42:19 INFO - ##### 06:42:19 INFO - ##### Running read-buildbot-config step. 06:42:19 INFO - ##### 06:42:19 INFO - Running pre-action listener: _resource_record_pre_action 06:42:19 INFO - Running main action method: read_buildbot_config 06:42:19 INFO - Using buildbot properties: 06:42:19 INFO - { 06:42:19 INFO - "project": "", 06:42:19 INFO - "product": "firefox", 06:42:19 INFO - "script_repo_revision": "production", 06:42:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:42:19 INFO - "repository": "", 06:42:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:42:19 INFO - "buildid": "20160622060501", 06:42:19 INFO - "pgo_build": "False", 06:42:19 INFO - "basedir": "/builds/slave/test", 06:42:19 INFO - "buildnumber": 1380, 06:42:19 INFO - "slavename": "talos-linux64-ix-038", 06:42:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:42:19 INFO - "platform": "ubuntu64_hw", 06:42:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:42:19 INFO - "branch": "fx-team", 06:42:19 INFO - "repo_path": "integration/fx-team", 06:42:19 INFO - "revision": "7687a980146e848a1c33ddc606d35fb046081ed8", 06:42:19 INFO - "stage_platform": "linux64", 06:42:19 INFO - "builduid": "e6e98a69332c483f8bf3d9ae1dcb126f", 06:42:19 INFO - "slavebuilddir": "test" 06:42:19 INFO - } 06:42:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:42:19 INFO - Running post-action listener: _resource_record_post_action 06:42:19 INFO - ##### 06:42:19 INFO - ##### Finished read-buildbot-config step (success) 06:42:19 INFO - ##### 06:42:19 INFO - ##### 06:42:19 INFO - ##### Running download-and-extract step. 06:42:19 INFO - ##### 06:42:19 INFO - Running pre-action listener: _resource_record_pre_action 06:42:19 INFO - Running main action method: download_and_extract 06:42:19 INFO - mkdir: /builds/slave/test/build/tests 06:42:19 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')]} 06:42:19 INFO - https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:20 INFO - Downloaded 1361 bytes. 06:42:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:42:20 INFO - Using the following test package requirements: 06:42:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:42:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:42:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'jsshell-linux-x86_64.zip'], 06:42:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:42:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:42:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:42:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:42:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:42:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:42:20 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')]} 06:42:20 INFO - https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:21 INFO - Downloaded 22703251 bytes. 06:42:21 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'] 06:42:21 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 06:42:22 INFO - Return code: 0 06:42:22 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 06:42:22 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')]} 06:42:22 INFO - https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:23 INFO - Downloaded 22703251 bytes. 06:42:23 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'] 06:42:23 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 06:42:25 INFO - Return code: 0 06:42:25 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')]} 06:42:25 INFO - https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:26 INFO - Downloaded 14405384 bytes. 06:42:26 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'] 06:42:26 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 06:42:26 INFO - Return code: 0 06:42:26 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')]} 06:42:26 INFO - https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 06:42:26 INFO - retry: attempt #1 caught exception: '' 06:42:26 INFO - retry: Failed, sleeping 30 seconds before retrying 06:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_DWxpo-Rv-363zBNByo5w/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 #2 06:42:58 INFO - Downloaded 56262294 bytes. 06:42:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:58 INFO - mkdir: /builds/slave/test/properties 06:42:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:58 INFO - Contents: 06:42:58 INFO - build_url:https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:58 INFO - Running post-action listener: _resource_record_post_action 06:42:58 INFO - Running post-action listener: set_extra_try_arguments 06:42:58 INFO - ##### 06:42:58 INFO - ##### Finished download-and-extract step (success) 06:42:58 INFO - ##### 06:42:58 INFO - ##### 06:42:58 INFO - ##### Running populate-webroot step. 06:42:58 INFO - ##### 06:42:58 INFO - Running pre-action listener: _resource_record_pre_action 06:42:58 INFO - Running main action method: populate_webroot 06:42:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:58 INFO - '--tppagecycles', 06:42:58 INFO - '7'], 06:42:58 INFO - 'tests': ['tsvgm']}}, 06:42:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['damp', 'tps']}, 06:42:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['damp', 'tps']}, 06:42:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['dromaeo_dom']}, 06:42:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['basic_compositor_video']}, 06:42:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:42:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tsvgx', 06:42:58 INFO - 'tsvgr_opacity', 06:42:58 INFO - 'tart', 06:42:58 INFO - 'tscrollx', 06:42:58 INFO - 'cart']}, 06:42:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:58 INFO - 'tsvgr_opacity', 06:42:58 INFO - 'tart', 06:42:58 INFO - 'tscrollx', 06:42:58 INFO - 'cart']}, 06:42:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tp5o']}, 06:42:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['tp5o']}, 06:42:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s', 06:42:58 INFO - '--xperf_path', 06:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:58 INFO - 'tests': ['tp5n']}, 06:42:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--xperf_path', 06:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:58 INFO - 'tests': ['tp5n']}}, 06:42:58 INFO - 'talos.zip': {'path': '', 06:42:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:58 INFO - Running post-action listener: _resource_record_post_action 06:42:58 INFO - ##### 06:42:58 INFO - ##### Finished populate-webroot step (success) 06:42:58 INFO - ##### 06:42:58 INFO - ##### 06:42:58 INFO - ##### Running create-virtualenv step. 06:42:58 INFO - ##### 06:42:58 INFO - Running pre-action listener: _resource_record_pre_action 06:42:58 INFO - Running main action method: create_virtualenv 06:42:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:58 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 06:42:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:58 INFO - Using real prefix '/usr' 06:42:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:43:01 INFO - Installing pip.................done. 06:43:01 INFO - Return code: 0 06:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:43:01 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')]} 06:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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')]} 06:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:01 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 06:43:01 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 06:43:01 INFO - Using env: {'DISPLAY': ':0', 06:43:01 INFO - 'HOME': '/home/cltbld', 06:43:01 INFO - 'LANG': 'en_US.UTF-8', 06:43:01 INFO - 'LANGUAGE': 'en_US:en', 06:43:01 INFO - 'LOGNAME': 'cltbld', 06:43:01 INFO - 'MAIL': '/var/mail/cltbld', 06:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:01 INFO - 'MOZ_NO_REMOTE': '1', 06:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:01 INFO - 'NO_EM_RESTART': '1', 06:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:01 INFO - 'PWD': '/builds/slave/test', 06:43:01 INFO - 'SHELL': '/bin/bash', 06:43:01 INFO - 'SHLVL': '1', 06:43:01 INFO - 'TERM': 'linux', 06:43:01 INFO - 'TMOUT': '86400', 06:43:01 INFO - 'USER': 'cltbld', 06:43:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:01 INFO - '_': '/tools/buildbot/bin/python'} 06:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:01 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 06:43:01 INFO - Cleaning up... 06:43:01 INFO - Return code: 0 06:43:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:43:01 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')]} 06:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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')]} 06:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:01 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 06:43:01 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 06:43:01 INFO - Using env: {'DISPLAY': ':0', 06:43:01 INFO - 'HOME': '/home/cltbld', 06:43:01 INFO - 'LANG': 'en_US.UTF-8', 06:43:01 INFO - 'LANGUAGE': 'en_US:en', 06:43:01 INFO - 'LOGNAME': 'cltbld', 06:43:01 INFO - 'MAIL': '/var/mail/cltbld', 06:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:01 INFO - 'MOZ_NO_REMOTE': '1', 06:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:01 INFO - 'NO_EM_RESTART': '1', 06:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:01 INFO - 'PWD': '/builds/slave/test', 06:43:01 INFO - 'SHELL': '/bin/bash', 06:43:01 INFO - 'SHLVL': '1', 06:43:01 INFO - 'TERM': 'linux', 06:43:01 INFO - 'TMOUT': '86400', 06:43:01 INFO - 'USER': 'cltbld', 06:43:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:01 INFO - '_': '/tools/buildbot/bin/python'} 06:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:01 INFO - Downloading/unpacking psutil>=3.1.1 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:03 INFO - Installing collected packages: psutil 06:43:03 INFO - Running setup.py install for psutil 06:43:04 INFO - building 'psutil._psutil_linux' extension 06:43:04 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 06:43:04 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 06:43:04 INFO - building 'psutil._psutil_posix' extension 06:43:04 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 06:43:04 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 06:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:04 INFO - Successfully installed psutil 06:43:04 INFO - Cleaning up... 06:43:04 INFO - Return code: 0 06:43:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:43:04 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')]} 06:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:04 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')]} 06:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:04 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:04 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 06:43:04 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 06:43:04 INFO - Using env: {'DISPLAY': ':0', 06:43:04 INFO - 'HOME': '/home/cltbld', 06:43:04 INFO - 'LANG': 'en_US.UTF-8', 06:43:04 INFO - 'LANGUAGE': 'en_US:en', 06:43:04 INFO - 'LOGNAME': 'cltbld', 06:43:04 INFO - 'MAIL': '/var/mail/cltbld', 06:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:04 INFO - 'MOZ_NO_REMOTE': '1', 06:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:04 INFO - 'NO_EM_RESTART': '1', 06:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:04 INFO - 'PWD': '/builds/slave/test', 06:43:04 INFO - 'SHELL': '/bin/bash', 06:43:04 INFO - 'SHLVL': '1', 06:43:04 INFO - 'TERM': 'linux', 06:43:04 INFO - 'TMOUT': '86400', 06:43:04 INFO - 'USER': 'cltbld', 06:43:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:04 INFO - '_': '/tools/buildbot/bin/python'} 06:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:43:06 INFO - Installing collected packages: mozsystemmonitor 06:43:06 INFO - Running setup.py install for mozsystemmonitor 06:43:06 INFO - Successfully installed mozsystemmonitor 06:43:06 INFO - Cleaning up... 06:43:06 INFO - Return code: 0 06:43:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:43:06 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')]} 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:06 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')]} 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:06 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:06 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 06:43:06 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 06:43:06 INFO - Using env: {'DISPLAY': ':0', 06:43:06 INFO - 'HOME': '/home/cltbld', 06:43:06 INFO - 'LANG': 'en_US.UTF-8', 06:43:06 INFO - 'LANGUAGE': 'en_US:en', 06:43:06 INFO - 'LOGNAME': 'cltbld', 06:43:06 INFO - 'MAIL': '/var/mail/cltbld', 06:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:06 INFO - 'MOZ_NO_REMOTE': '1', 06:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:06 INFO - 'NO_EM_RESTART': '1', 06:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:06 INFO - 'PWD': '/builds/slave/test', 06:43:06 INFO - 'SHELL': '/bin/bash', 06:43:06 INFO - 'SHLVL': '1', 06:43:06 INFO - 'TERM': 'linux', 06:43:06 INFO - 'TMOUT': '86400', 06:43:06 INFO - 'USER': 'cltbld', 06:43:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:06 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 INFO - Downloading/unpacking jsonschema==2.5.1 06:43:07 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 06:43:07 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 06:43:07 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 06:43:07 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 06:43:07 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 06:43:07 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 06:43:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:43:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:43:08 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 06:43:08 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 06:43:08 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 06:43:08 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 06:43:08 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 06:43:08 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 06:43:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:43:09 INFO - warning: no files found matching '*.txt' 06:43:09 INFO - no previously-included directories found matching 'build' 06:43:09 INFO - no previously-included directories found matching 'dist' 06:43:09 INFO - no previously-included directories found matching '.git*' 06:43:09 INFO - Installing collected packages: jsonschema, functools32 06:43:09 INFO - Running setup.py install for functools32 06:43:09 INFO - warning: no files found matching '*.txt' 06:43:09 INFO - no previously-included directories found matching 'build' 06:43:09 INFO - no previously-included directories found matching 'dist' 06:43:09 INFO - no previously-included directories found matching '.git*' 06:43:09 INFO - Successfully installed jsonschema functools32 06:43:09 INFO - Cleaning up... 06:43:09 INFO - Return code: 0 06:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:43:09 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')]} 06:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:09 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')]} 06:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:09 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:09 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 06:43:09 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 06:43:09 INFO - Using env: {'DISPLAY': ':0', 06:43:09 INFO - 'HOME': '/home/cltbld', 06:43:09 INFO - 'LANG': 'en_US.UTF-8', 06:43:09 INFO - 'LANGUAGE': 'en_US:en', 06:43:09 INFO - 'LOGNAME': 'cltbld', 06:43:09 INFO - 'MAIL': '/var/mail/cltbld', 06:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:09 INFO - 'MOZ_NO_REMOTE': '1', 06:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:09 INFO - 'NO_EM_RESTART': '1', 06:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:09 INFO - 'PWD': '/builds/slave/test', 06:43:09 INFO - 'SHELL': '/bin/bash', 06:43:09 INFO - 'SHLVL': '1', 06:43:09 INFO - 'TERM': 'linux', 06:43:09 INFO - 'TMOUT': '86400', 06:43:09 INFO - 'USER': 'cltbld', 06:43:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:09 INFO - '_': '/tools/buildbot/bin/python'} 06:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 06:43:09 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 06:43:09 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 06:43:09 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 06:43:09 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 06:43:09 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 06:43:09 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 06:43:11 INFO - Downloading blobuploader-1.2.4.tar.gz 06:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:43:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:43:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:12 INFO - Downloading docopt-0.6.1.tar.gz 06:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:43:12 INFO - Installing collected packages: blobuploader, requests, docopt 06:43:12 INFO - Running setup.py install for blobuploader 06:43:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:43:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:43:12 INFO - Running setup.py install for requests 06:43:12 INFO - Running setup.py install for docopt 06:43:13 INFO - Successfully installed blobuploader requests docopt 06:43:13 INFO - Cleaning up... 06:43:13 INFO - Return code: 0 06:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:13 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')]} 06:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:13 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')]} 06:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:13 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:13 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 06:43:13 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 06:43:13 INFO - Using env: {'DISPLAY': ':0', 06:43:13 INFO - 'HOME': '/home/cltbld', 06:43:13 INFO - 'LANG': 'en_US.UTF-8', 06:43:13 INFO - 'LANGUAGE': 'en_US:en', 06:43:13 INFO - 'LOGNAME': 'cltbld', 06:43:13 INFO - 'MAIL': '/var/mail/cltbld', 06:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:13 INFO - 'MOZ_NO_REMOTE': '1', 06:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:13 INFO - 'NO_EM_RESTART': '1', 06:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:13 INFO - 'PWD': '/builds/slave/test', 06:43:13 INFO - 'SHELL': '/bin/bash', 06:43:13 INFO - 'SHLVL': '1', 06:43:13 INFO - 'TERM': 'linux', 06:43:13 INFO - 'TMOUT': '86400', 06:43:13 INFO - 'USER': 'cltbld', 06:43:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:13 INFO - '_': '/tools/buildbot/bin/python'} 06:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:13 INFO - Running setup.py (path:/tmp/pip-BW2Bo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:13 INFO - Running setup.py (path:/tmp/pip-8gzGJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:13 INFO - Running setup.py (path:/tmp/pip-j4dwyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:13 INFO - Running setup.py (path:/tmp/pip-ln4Npy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:13 INFO - Running setup.py (path:/tmp/pip-WJzNyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:13 INFO - Running setup.py (path:/tmp/pip-rTozgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:13 INFO - Running setup.py (path:/tmp/pip-MBvyWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:13 INFO - Running setup.py (path:/tmp/pip-s_5ltK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:13 INFO - Running setup.py (path:/tmp/pip-ghC_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:13 INFO - Running setup.py (path:/tmp/pip-r42uUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:14 INFO - Running setup.py (path:/tmp/pip-GjLS9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:14 INFO - Running setup.py (path:/tmp/pip-mP2u5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:14 INFO - Running setup.py (path:/tmp/pip-zT6Ped-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:14 INFO - Running setup.py (path:/tmp/pip-5EEiGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:14 INFO - Running setup.py (path:/tmp/pip-VXO8PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:14 INFO - Running setup.py (path:/tmp/pip-lcDuIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:14 INFO - Running setup.py (path:/tmp/pip-iWX7LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:43:14 INFO - Running setup.py install for manifestparser 06:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:43:14 INFO - Running setup.py install for mozcrash 06:43:14 INFO - Running setup.py install for mozdebug 06:43:14 INFO - Running setup.py install for mozdevice 06:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:43:14 INFO - Running setup.py install for mozfile 06:43:15 INFO - Running setup.py install for mozhttpd 06:43:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for mozinfo 06:43:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for mozInstall 06:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for mozleak 06:43:15 INFO - Running setup.py install for mozlog 06:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for moznetwork 06:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for mozprocess 06:43:15 INFO - Running setup.py install for mozprofile 06:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:43:15 INFO - Running setup.py install for mozrunner 06:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:43:16 INFO - Running setup.py install for mozscreenshot 06:43:16 INFO - Running setup.py install for moztest 06:43:16 INFO - Running setup.py install for mozversion 06:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:43:16 INFO - Cleaning up... 06:43:16 INFO - Return code: 0 06:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:16 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')]} 06:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:16 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')]} 06:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:16 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:16 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 06:43:16 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 06:43:16 INFO - Using env: {'DISPLAY': ':0', 06:43:16 INFO - 'HOME': '/home/cltbld', 06:43:16 INFO - 'LANG': 'en_US.UTF-8', 06:43:16 INFO - 'LANGUAGE': 'en_US:en', 06:43:16 INFO - 'LOGNAME': 'cltbld', 06:43:16 INFO - 'MAIL': '/var/mail/cltbld', 06:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:16 INFO - 'MOZ_NO_REMOTE': '1', 06:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:16 INFO - 'NO_EM_RESTART': '1', 06:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:16 INFO - 'PWD': '/builds/slave/test', 06:43:16 INFO - 'SHELL': '/bin/bash', 06:43:16 INFO - 'SHLVL': '1', 06:43:16 INFO - 'TERM': 'linux', 06:43:16 INFO - 'TMOUT': '86400', 06:43:16 INFO - 'USER': 'cltbld', 06:43:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:16 INFO - '_': '/tools/buildbot/bin/python'} 06:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:16 INFO - Running setup.py (path:/tmp/pip-QVrZFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:16 INFO - Running setup.py (path:/tmp/pip-1ziAG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:16 INFO - Running setup.py (path:/tmp/pip-jTwxQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:16 INFO - Running setup.py (path:/tmp/pip-h2Qgz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:16 INFO - Running setup.py (path:/tmp/pip-SdWzb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:16 INFO - Running setup.py (path:/tmp/pip-JUskYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:16 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)) 06:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:16 INFO - Running setup.py (path:/tmp/pip-ZGiH8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:17 INFO - Running setup.py (path:/tmp/pip-tb4vG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:17 INFO - Running setup.py (path:/tmp/pip-5aRrCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:17 INFO - Running setup.py (path:/tmp/pip-8M3IUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:17 INFO - Running setup.py (path:/tmp/pip-sw5E7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:17 INFO - Running setup.py (path:/tmp/pip-HgOXGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:17 INFO - Running setup.py (path:/tmp/pip-uSruwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:17 INFO - Running setup.py (path:/tmp/pip-3BiOiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:17 INFO - Running setup.py (path:/tmp/pip-OMPqXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:17 INFO - Running setup.py (path:/tmp/pip-Vo_4ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:17 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)) 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:17 INFO - Running setup.py (path:/tmp/pip-mAkhOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:17 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)) 06:43:17 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)) 06:43:17 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)) 06:43:17 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)) 06:43:17 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)) 06:43:17 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)) 06:43:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:43:17 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 06:43:17 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 06:43:17 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 06:43:17 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 06:43:17 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 06:43:17 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 06:43:19 INFO - Downloading blessings-1.6.tar.gz 06:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:43:19 INFO - Installing collected packages: blessings 06:43:19 INFO - Running setup.py install for blessings 06:43:19 INFO - Successfully installed blessings 06:43:19 INFO - Cleaning up... 06:43:19 INFO - Return code: 0 06:43:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:20 INFO - Reading from file tmpfile_stdout 06:43:20 INFO - Current package versions: 06:43:20 INFO - argparse == 1.2.1 06:43:20 INFO - blessings == 1.6 06:43:20 INFO - blobuploader == 1.2.4 06:43:20 INFO - docopt == 0.6.1 06:43:20 INFO - functools32 == 3.2.3-2 06:43:20 INFO - jsonschema == 2.5.1 06:43:20 INFO - manifestparser == 1.1 06:43:20 INFO - mozInstall == 1.12 06:43:20 INFO - mozcrash == 0.17 06:43:20 INFO - mozdebug == 0.1 06:43:20 INFO - mozdevice == 0.48 06:43:20 INFO - mozfile == 1.2 06:43:20 INFO - mozhttpd == 0.7 06:43:20 INFO - mozinfo == 0.9 06:43:20 INFO - mozleak == 0.1 06:43:20 INFO - mozlog == 3.2 06:43:20 INFO - moznetwork == 0.27 06:43:20 INFO - mozprocess == 0.22 06:43:20 INFO - mozprofile == 0.28 06:43:20 INFO - mozrunner == 6.11 06:43:20 INFO - mozscreenshot == 0.1 06:43:20 INFO - mozsystemmonitor == 0.3 06:43:20 INFO - moztest == 0.7 06:43:20 INFO - mozversion == 1.4 06:43:20 INFO - psutil == 3.1.1 06:43:20 INFO - requests == 1.2.3 06:43:20 INFO - wsgiref == 0.1.2 06:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:20 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')]} 06:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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')]} 06:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:20 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 06:43:20 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 06:43:20 INFO - Using env: {'DISPLAY': ':0', 06:43:20 INFO - 'HOME': '/home/cltbld', 06:43:20 INFO - 'LANG': 'en_US.UTF-8', 06:43:20 INFO - 'LANGUAGE': 'en_US:en', 06:43:20 INFO - 'LOGNAME': 'cltbld', 06:43:20 INFO - 'MAIL': '/var/mail/cltbld', 06:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:20 INFO - 'MOZ_NO_REMOTE': '1', 06:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:20 INFO - 'NO_EM_RESTART': '1', 06:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:20 INFO - 'PWD': '/builds/slave/test', 06:43:20 INFO - 'SHELL': '/bin/bash', 06:43:20 INFO - 'SHLVL': '1', 06:43:20 INFO - 'TERM': 'linux', 06:43:20 INFO - 'TMOUT': '86400', 06:43:20 INFO - 'USER': 'cltbld', 06:43:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:20 INFO - '_': '/tools/buildbot/bin/python'} 06:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 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)) 06:43:20 INFO - Cleaning up... 06:43:20 INFO - Return code: 0 06:43:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:43:20 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')]} 06:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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')]} 06:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:20 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 06:43:20 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 06:43:20 INFO - Using env: {'DISPLAY': ':0', 06:43:20 INFO - 'HOME': '/home/cltbld', 06:43:20 INFO - 'LANG': 'en_US.UTF-8', 06:43:20 INFO - 'LANGUAGE': 'en_US:en', 06:43:20 INFO - 'LOGNAME': 'cltbld', 06:43:20 INFO - 'MAIL': '/var/mail/cltbld', 06:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:20 INFO - 'MOZ_NO_REMOTE': '1', 06:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:20 INFO - 'NO_EM_RESTART': '1', 06:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:20 INFO - 'PWD': '/builds/slave/test', 06:43:20 INFO - 'SHELL': '/bin/bash', 06:43:20 INFO - 'SHLVL': '1', 06:43:20 INFO - 'TERM': 'linux', 06:43:20 INFO - 'TMOUT': '86400', 06:43:20 INFO - 'USER': 'cltbld', 06:43:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:20 INFO - '_': '/tools/buildbot/bin/python'} 06:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:43:20 INFO - Cleaning up... 06:43:20 INFO - Return code: 0 06:43:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:43:20 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')]} 06:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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')]} 06:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:20 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 0x7fd61bd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2383350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, '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': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', '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 06:43:20 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 06:43:20 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 06:43:20 INFO - Using env: {'DISPLAY': ':0', 06:43:20 INFO - 'HOME': '/home/cltbld', 06:43:20 INFO - 'LANG': 'en_US.UTF-8', 06:43:20 INFO - 'LANGUAGE': 'en_US:en', 06:43:20 INFO - 'LOGNAME': 'cltbld', 06:43:20 INFO - 'MAIL': '/var/mail/cltbld', 06:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:20 INFO - 'MOZ_NO_REMOTE': '1', 06:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:20 INFO - 'NO_EM_RESTART': '1', 06:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:20 INFO - 'PWD': '/builds/slave/test', 06:43:20 INFO - 'SHELL': '/bin/bash', 06:43:20 INFO - 'SHLVL': '1', 06:43:20 INFO - 'TERM': 'linux', 06:43:20 INFO - 'TMOUT': '86400', 06:43:20 INFO - 'USER': 'cltbld', 06:43:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:20 INFO - '_': '/tools/buildbot/bin/python'} 06:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:20 INFO - Downloading/unpacking flake8 06:43:20 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 06:43:20 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 06:43:20 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 06:43:20 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 06:43:20 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 06:43:20 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 06:43:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:43:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:43:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:22 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 06:43:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:43:23 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 06:43:23 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 06:43:23 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 06:43:23 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 06:43:23 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 06:43:23 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 06:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:43:23 INFO - no previously-included directories found matching 'docs/_build' 06:43:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:43:23 INFO - Running setup.py install for pep8 06:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:43:23 INFO - no previously-included directories found matching 'docs/_build' 06:43:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:43:23 INFO - Cleaning up... 06:43:23 INFO - Return code: 0 06:43:23 INFO - Running post-action listener: _resource_record_post_action 06:43:23 INFO - Running post-action listener: _start_resource_monitoring 06:43:23 INFO - Starting resource monitoring. 06:43:23 INFO - ##### 06:43:23 INFO - ##### Finished create-virtualenv step (success) 06:43:23 INFO - ##### 06:43:23 INFO - ##### 06:43:23 INFO - ##### Running install step. 06:43:23 INFO - ##### 06:43:23 INFO - Running pre-action listener: _resource_record_pre_action 06:43:23 INFO - Running main action method: install 06:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:23 INFO - Reading from file tmpfile_stdout 06:43:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:43:24 INFO - Reading from file tmpfile_stdout 06:43:24 INFO - Output received: 06:43:24 INFO - Usage: mozinstall [options] installer 06:43:24 INFO - Options: 06:43:24 INFO - -h, --help show this help message and exit 06:43:24 INFO - -d DEST, --destination=DEST 06:43:24 INFO - Directory to install application into. [default: 06:43:24 INFO - "/builds/slave/test"] 06:43:24 INFO - --app=APP Application being installed. [default: firefox] 06:43:24 INFO - mkdir: /builds/slave/test/build/application 06:43:24 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'] 06:43:24 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 06:43:40 INFO - Reading from file tmpfile_stdout 06:43:40 INFO - Output received: 06:43:40 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:40 INFO - Running post-action listener: _resource_record_post_action 06:43:40 INFO - ##### 06:43:40 INFO - ##### Finished install step (success) 06:43:40 INFO - ##### 06:43:40 INFO - ##### 06:43:40 INFO - ##### Running run-tests step. 06:43:40 INFO - ##### 06:43:40 INFO - Running pre-action listener: _resource_record_pre_action 06:43:40 INFO - Running main action method: run_tests 06:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:40 INFO - Python 2.7.3 06:43:40 INFO - Return code: 0 06:43:40 INFO - grabbing minidump binary from tooltool 06:43:40 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')]} 06:43:40 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 0x24121c0>, '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 0x24130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2413550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:40 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 06:43:40 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 06:43:40 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 06:43:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:40 INFO - Return code: 0 06:43:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:43:41 INFO - Return code: 0 06:43:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:43:41 INFO - Using env: {'DISPLAY': ':0', 06:43:41 INFO - 'HOME': '/home/cltbld', 06:43:41 INFO - 'LANG': 'en_US.UTF-8', 06:43:41 INFO - 'LANGUAGE': 'en_US:en', 06:43:41 INFO - 'LOGNAME': 'cltbld', 06:43:41 INFO - 'MAIL': '/var/mail/cltbld', 06:43:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:41 INFO - 'MOZ_NO_REMOTE': '1', 06:43:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:41 INFO - 'NO_EM_RESTART': '1', 06:43:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:41 INFO - 'PWD': '/builds/slave/test', 06:43:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:41 INFO - 'SHELL': '/bin/bash', 06:43:41 INFO - 'SHLVL': '1', 06:43:41 INFO - 'TERM': 'linux', 06:43:41 INFO - 'TMOUT': '86400', 06:43:41 INFO - 'USER': 'cltbld', 06:43:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945', 06:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:41 INFO - '_': '/tools/buildbot/bin/python'} 06:43:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:43:41 INFO - mozversion application_buildid: 20160622060501 06:43:41 INFO - mozversion application_changeset: 7687a980146e848a1c33ddc606d35fb046081ed8 06:43:41 INFO - mozversion application_display_name: Nightly 06:43:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:41 INFO - mozversion application_name: Firefox 06:43:41 INFO - mozversion application_remotingname: firefox 06:43:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:43:41 INFO - mozversion application_vendor: Mozilla 06:43:41 INFO - mozversion application_version: 50.0a1 06:43:41 INFO - mozversion platform_buildid: 20160622060501 06:43:41 INFO - mozversion platform_changeset: 7687a980146e848a1c33ddc606d35fb046081ed8 06:43:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:43:41 INFO - mozversion platform_version: 50.0a1 06:43:41 INFO - using testdate: 1466603021 06:43:41 INFO - actual date: 1466603021 06:43:41 INFO - starting webserver on 'localhost:37440' 06:43:41 INFO - SUITE-START | Running 2 tests 06:43:41 INFO - TEST-START | dromaeo_css 06:43:41 INFO - operating with platform_type : linux_ 06:43:41 INFO - Initialising browser for dromaeo_css test... 06:43:41 INFO - TEST-INFO | started process 9704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBNRMml/profile http://localhost:37440/getInfo.html) 06:43:47 INFO - PROCESS | 9704 | __metrics Screen width/height:1600/1200 06:43:47 INFO - PROCESS | 9704 | colorDepth:24 06:43:47 INFO - PROCESS | 9704 | Browser inner width/height: 1024/697 06:43:47 INFO - PROCESS | 9704 | __metrics 06:43:47 ERROR - PROCESS | 9704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:43:48 INFO - TEST-INFO | 9704: exit 0 06:43:48 INFO - Browser initialized. 06:43:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:43:48 INFO - TEST-INFO | started process 9820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBNRMml/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:01 INFO - PROCESS | 9820 | RSS: Main: 185729024 06:44:01 INFO - PROCESS | 9820 | 06:44:50 INFO - PROCESS | 9820 | 1466603090656 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] 06:47:03 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37440/tests/dromaeo/cssquery-ext.html) 06:47:04 INFO - PROCESS | 9820 | RSS: Main: 188837888 06:47:04 INFO - PROCESS | 9820 | 06:50:06 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-ext.html (next: http://localhost:37440/tests/dromaeo/cssquery-jquery.html) 06:50:06 INFO - PROCESS | 9820 | RSS: Main: 188067840 06:50:06 INFO - PROCESS | 9820 | 06:53:08 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37440/tests/dromaeo/cssquery-mootools.html) 06:53:09 INFO - PROCESS | 9820 | RSS: Main: 189042688 06:53:09 INFO - PROCESS | 9820 | 06:56:11 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37440/tests/dromaeo/cssquery-prototype.html) 06:56:12 INFO - PROCESS | 9820 | RSS: Main: 186433536 06:56:12 INFO - PROCESS | 9820 | 06:59:14 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37440/tests/dromaeo/cssquery-yui.html) 06:59:15 INFO - PROCESS | 9820 | RSS: Main: 188821504 06:59:15 INFO - PROCESS | 9820 | 07:02:17 INFO - PROCESS | 9820 | Cycle 1(1): loaded http://localhost:37440/tests/dromaeo/cssquery-yui.html (next: http://localhost:37440/tests/dromaeo/cssquery-dojo.html) 07:02:18 INFO - PROCESS | 9820 | RSS: Main: 189771776 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | __start_tp_report 07:02:18 INFO - PROCESS | 9820 | _x_x_mozilla_page_load 07:02:18 INFO - PROCESS | 9820 | _x_x_mozilla_page_load_details 07:02:18 INFO - PROCESS | 9820 | |i|pagename|runs| 07:02:18 INFO - PROCESS | 9820 | |0;dojo.html;2634.5126151661943;2654.9911033807152;2667.0398656483662;2700.3519155402696;2701.4732127235184;4919.999999999995;4963.578095861856;4973.880876802727;4974.975125124374;4975.950240497598;4836.492168322319;4922.1878390065685;4950.059488697145;4950.430700469438;4982.725950072744;4475.753833539154;4504.144212599612;4608.976955115219;4617.538246175389;4639.211334073216;544.4546396681307;4491.483479399878;4523.140603285382;4605.378273933026;4657.5575320344515;4519.638428925678;4534.025184585314;4560.88597785058;4564.338170965225;4605.125026245037;4470.977645111786;4563.041761230145;4581.221192397267;4586.105709386671;4619.422572178478;4498.415206023229;4550.68145229834;4595.379623750784;4600.746958917258;4601.056783359437;4997.30037794709;5023.773930173114;5063.54428101469;5086.41506226785;5105.387353517564;5308.761105750251;5371.221172929942;5427.891442171174;5432.320959880015;5447.591430642718;5414.07960646691;5427.891442171134;5431.755570999315;5432.266644003088;5465.672059676433;5040.697558146523;5053.065182941167;5055.9241611375855;5056.292119103328;5098.413682426494;5371.409144994048;5450.754716037788;5506.339239291311;5523.502884740312;5554.888902221933;5222.764975576109;5241.24002019705;5262.710550919736;5263.526282634504;5265.76304066318;5383.111786555253;5385.946140538623;5395.406505284415;5398.325209348832;5440.129579267298;5216.061109000417;5281.603879709037;5333.626646134733;5339.985402773461;5355.3305836770405;5245.7114858683135;5249.501297376743;5268.394134674485;5298.947010529922;5301.257823904656;4535.047639995571;4544.772761361919;4547.658925580595;4557.407537020233;4603.861884143481;3856.1130939883983;3929.096307849211;3942.8817135485406;3947.486826712509;3976.1252524444576;4591.885202869888;4601.7699115044115;4602.4477062752685;4608.539146085432;4633.860984170413;5206.76569554371;5422.593305502103;5439.864003399867;5449.209864569615;5450.236966824647;4526.79629416677;4572.1312950539295;4572.268437050056;4579.771011449414;4586.197415452282;4844.32179494871;4855.295982082578;4855.902881942412;4867.050925069578;4931.137051016058;4868.586170175433;4966.8758281043265;5029.5221953914315;5036.924446133237;5100.081985242692;5367.490088441592;5389.326334208224;5403.270558474713;5427.1316589345515;5454.863628409322;5049.065922804146;5059.663487942425;5070.3155074064525;5084.466131056186;5126.102931986962;5132.717700526507;5213.061648903234;5252.474752524717;5316.229146773773;5322.760475778677;5353.116735738559;5358.839234822962;5371.140617501337;5380.11228147367;5383.67697938125;5154.433012368711;5174.96500699854;5175.37895452533;5189.221616757516;5238.633295669419;5072.492750724898;5135.794568217229;5177.792888284426;5180.119379705535;5225.268462415341;4958.975205123951;5123.513266239701;5125.359330083739;5137.8201762938115;5140.640155189101;5259.421463639073;5271.367435907716;5278.2346559749385;5285.101532739367;5336.546393556591;4997.225430058346;5107.284980102863;5121.873187898656;5167;5180.7409629519125 07:02:18 INFO - PROCESS | 9820 | |1;ext.html;560.1449557729027;572.8739677271001;592.6947621974684;597.5488506177835;617.8887800195963;35283.4707479388;39023.80488097563;39049.219015619674;39156.99999999993;39169.21661566767;39575.604243957554;40034.199316013735;40121.39817902727;40132.59867401325;40265;7708.344790692798;7867.1739467355965;7867.331276841475;7870.685172593089;7886.960565197166;7770.689172433096;7854.842903141934;7876.015498062742;7898.80252993674;7901.644426000844;7888.723894663688;7907.16974717655;7924.564148971805;7929.881051784228;7959.880601790977;7759.728409505668;7838.451308408414;7840.4511684182135;7863.213678632148;7873.25204105609;7653.579053152074;7740.8838867417035;7749.573773442458;7760.262775036363;7761.379089672812;37550.81224593887;37576.812115939516;37676.24647507062;37721.43417848735;37820.810895945346;3107.735842453394;3276.9016929492154;3361.3949489091956;3443.9655603443894;3519;29459.70540294591;29799.25501862449;29951.700482995107;29958.10125696211;30060.8496957516;3575.66031227033;3581.6776490116013;3658.652428019334;3727.7390582659223;3737.2338670572467;254433;255825;257122;257210;257403.71298143576;45708.542914571095;51693;53145;53494.46505534973;57880.421195788345;55482.445175548535;55722.72138639281;55888.441115589136;55920;55965.7201713997;13668.52160174389;13753.38109785062;13760.93119534396;13780;13781;11005.61480348184;11017;11061.391623460788;11112.333260004425;11374.431278436045;15873.206339682969;16104.436344727877;16110.67778644444;16133.67732645364;16169.029858208545;5866.05150021723;5981;6084.847878803065;6104.542159338067;6123.173371594867;830.7507747675673;899.4827973915025;912.8539433690711;937.7421209167534;982.6216906491053;27616.447671046466;28253.15240542787;28386;28664.283392915346;28779.136625901258;927.3647551427159;960.8030353777459;972.9464879431699;992.2437286003733;1022.0648106982177;14223.431062757581;14328.426862925366;14478.782818257734;14567.854321456862;14644.12135271887;369151;373532;373831;373849;374301;48809;48815.26777098346;48865.75567122213;49053.754731226116;49085.75457122691;1150.9597164099384;1202.2185579373477;1216.853977522703;1222.0529089955355;1229.1764517773113;26468.867655661597;27277.318067048483;27302.863485682443;27320.726792731817;27653.446931060862;41481.37777933273;42053.36919946142;42116.36825447682;42225.36661950012;42451.3632295522;340950;341042;341117;341909;342649;24465.3883652903;24743.50512989766;24940.875295623406;24958;25016.37459063538;42245.577544224165;42254.577454225066;42863.14273714446;43039.784801075795;43563;36427.81786091052;36438.63561364352;36703.265934681694;36846;37142.44286335761;36062.45906311355;36076;36655;36883.815580922994;37289.254214916094;35500.467492988144;35816.4627530582;36079.45880811843;36360.27279454449;36412.4538131923;31929.201769955936;32818;32933.34133317368;33491.330173396884;33709;25252;25324.493510129327;25375.492490149725;25792.226233213034;26060.739392605832 07:02:18 INFO - PROCESS | 9820 | |2;jquery.html;371.21488052768393;376.3019598644514;376.31135022908063;393.4177417422213;397.4415945596438;15925.12411817351;16437.260323285453;17112.74330885038;17187.570310742238;17342.82657173428;13189.406476708547;13872.722545549082;14728.705425891476;14734.705305893876;15200.239988000583;4697.929531057045;4858.833879868824;4867.9269810952865;4895.069936712013;4895.55939965403;3496.4230901901155;5376.569874410038;5619.353774315945;5625;5706.800261990831;5664.745086471119;5671.602987790856;5683.119116536944;5713.542916566665;5802.332731735841;6102.847428814293;6231.034189700558;6242.906356404635;6248.218972628421;6269.247690277173;5313.57491400687;5483.7806487740445;5529.861753456155;5532.944670553283;5547.972260138714;13040.152390094709;13066.673333166651;17645.294188232456;20419.693704594443;20617.58764824695;1887.2356695538328;1902.4387805597244;1913.5885784556249;1937.118611031977;1994.9301774437824;9494.572744226458;9682;10320.535575899103;11327.603533876274;13703.588892333146;1726.4647959132583;1759.7536344911723;1794.1657129434745;1803.9007854567994;1814.8548116150807;69610.30389696089;70476.6476167621;70536;70571.64714176448;71144.64427677829;9911.65309214174;10242.59029638821;10326.22553308505;10461.006204410569;10612.734681632866;14356.712865742627;14389.712205755826;14443.78334324986;14444.855551444562;14509.129452232688;7044.450220951382;7504.699812007568;7618.961905190438;7751.534907905544;7811.336036436853;7239.420846332281;7300.671469783872;7344.96327518359;7363.889541656772;7480.0649918760155;4282.657387409;4389.582989615981;4473.485549161823;4476.239039363316;4538.069695712371;1693.7544056111794;1750.544858336816;1874.147262995334;1921.2603147788202;1925.3935010471657;837.1475559254158;843.8776377425239;873.5675840458887;885.6944354197791;932.8414169591185;16459.423920162735;16794.53713537068;16965.236564354633;16972.575685607957;17188.656226875642;854.811941372897;858.6908712863365;865.8311629232365;881.8809460722721;883.7186080183759;9185.007735689056;9625.71122866315;9637.37357071788;9669.419834809934;9808.313418060667;380214;398260;405163;405559;423254;76624.61687691526;78407;78512.60743696245;78666.6066669663;78735.21264787394;874.7681864305964;892.901780804111;911.0570559471048;913.9451632902047;918.7289749523907;15104.471343502924;15308.158051307286;15503.224838758242;15527.456539021532;15805.604859878595;34272;34380.31239375148;34776.30447391089;36150.09624759402;36502.087447812955;47487.76256118697;52235.47764522306;53292.4670753303;53484.73257633687;54228.457715422344;7900.209979002054;7974.8006299840645;8023.6790528378215;8175.182481751777;8287.295579875537;8900;11680.70798230051;12260.693482663004;12374.566890159162;12382.442790074288;10051.296409251283;10218.846717299099;10369.63706270277;10672.519736611715;10920.399378033966;10291.742706432398;10499.527521261714;10569.735756606146;10612.522436490222;10742.89257107419;6149.508039356751;9434.764130896783;9976;10393.844092338772;10509.579616815241;7406.888896666662;7712.228777122243;7762.223777622193;7883.251091146332;8133.877991830009;9694.321397502106;10093;10235.84646230322;10385.376877387382;10956.945215273872 07:02:18 INFO - PROCESS | 9820 | |3;mootools.html;1354.05216348556;1400.7688731359326;1475.6532214929496;1643.3180230204466;1694.2121913310316;6848.246692863781;7514.624268786566;7600.885986710196;8112.1076681565055;8113.148119447462;7650.234976502347;7746.651400686968;7862.449628526006;7871.92128078719;7873.291403773674;2166.815820655242;2217.545403192342;2224.8665080095248;2229.0303717882693;2230.4423894026495;2182.552576721776;2212.5685491329195;2250.2011785816044;2256.9322920312416;2262.321303608919;2206.79035491628;2223.6442169252923;2224.7997680208778;2239.529698763262;2264.739554951177;2159.762426133124;2187.103287652063;2207.8233741300655;2223.0885337011828;2224.143704673696;2200.7359116905914;2227.6658501224783;2231.0518029837417;2236.563870045342;2236.7539570647214;7821.21787821219;7876.409269304825;7877;7877.881831772528;7899.210078992112;4734.573888350065;4877.8780530486665;4880.487548807395;4884.096442158212;4897.142999975025;2911.898083567065;2983.4928062229474;3091.1035799618085;3100.767442441826;3115.1121930249997;955.6034245787989;982.8280050991119;986.3539381704994;986.7335819328813;1013.8327176015948;10850.837237441445;10853;10864.185186111074;10866.782664346747;10902.836457453144;4266.850660226877;4411.250087485135;4414.1171765647;4457.821687132543;4508.413906192174;9299.72100836976;9325.114114159143;9340.112689294507;9343.505039193833;9347.672831451002;4693.084848454587;4700.106979673919;4708.199606066977;4716.528347165325;4728.692634978715;3780.5652349979555;4213.262679031157;4261.552536983572;4348.412964249849;4395.450568678915;3685.1155722626377;3705.925881482355;3787.223619158121;3804.4673745675627;3810.7523011004196;1160.0255785140523;1179.5281887245171;1206.6621346023128;1229.1088960503564;1230.1143176912608;729.2488736601309;766.5707203965796;823.5223570329194;835.4820011592851;840.1976112812249;4919.311296418504;4995.375578052744;5007.924881126786;5077.31456253401;5192.324997750268;853.38129855854;888.9688860889838;891.0910870911633;892.125716797542;903.051795614602;3338.382399256145;3410.6248312685584;3477.8608855646;3506.088417011544;3516.909757975036;9376.95311523438;9698.739163908647;9701.70894873155;9866.30935834499;9898.901010989943;9799.510024498746;9833.557489912972;9835.262355323379;9842.606295748234;9866.703998880044;7230.674619642129;7331.926680733124;7365.329470247946;7458.701651933862;7503.662335194929;4834.613230941586;4897.804087836446;4931.9753401232765;4969.47820478859;5019.824306149268;9071.274298056007;9087.545622718706;9092.090790920854;9135.588898499716;9148.588313525774;8973.596188171417;9276.58255378523;9309.581068851783;9318.394304370195;9354.345195836226;5847.707614619337;6220.222472190976;6460.676966151767;6491.545591808528;6603.174603174603;7749.070111586646;7749.845003100019;7757.806054848674;7811.140774514685;7828.13890472059;6805.2854450283985;7030.718771249298;7127.144742630918;7165.820854478679;7252.238514955854;6950.443964482728;6971.79084627462;7020.7542736004;7023.859522809617;7085.504014719127;6021.187139736079;6049.818505444844;6098.908516372169;6100.1459795629535;6110.694465276807;4331.350297455407;4361.389405483298;4386.429764130643;4394.318880573516;4430;4423.579759922803;4510.458744950627;4544.136614043321;4564.356831540709;4669.696469729457 07:02:18 INFO - PROCESS | 9820 | |4;prototype.html;310.9751219902408;311.61204300645693;313.17009923702193;319.04923328481124;319.8145075856001;5187.910538786855;5232.16285394337;5244.947550524494;5251.816186433475;5252.238425428315;5102.897942041157;5120.769565369558;5133.1786914093755;5141.974290128554;5146.768395422206;3790.734648574594;3878.747881387715;3985.7409268397605;3985.9202815943663;3994.5805690402526;3993.760374377532;4009.939850902239;4023.215472982755;4027.1140349123148;4031.496062992126;4008.118213992917;4018.5177778666457;4020.5376381716037;4057.431959525669;4059.776712280823;3734.514513113278;3960.4653371794725;3970.980145099285;4037.97981010096;4062.6343629073376;3439.6044454887756;3455.4989526518766;3457.1184347991352;3459.1697992481877;3480.8085555294447;5039.319691841628;5039.672421292641;5068.695878247317;5074.797008119708;5102.591792656579;4336.34954756789;4559.658025648089;4584.106099310636;4602.309653551961;4641.86074417768;5384.623076384654;5423.783048678088;5472.26124473195;5485.204645326446;5497.890042199134;3723.6834869035893;3761.37937240355;3806.3148633246283;3809.2381523695094;3817.866374676873;5375.516203541661;5734.197212390269;5750.1949727038245;5755.597108202427;5771.855703607402;3973.7814420206587;3987.5613682494904;3991.1818077294083;4016.136530645925;4024.7461421603994;4070.531888832763;4079.3676980068135;4093.5087789465456;4095.365218391154;4108.43222985634;4664;4672.883177920579;4674.883127921761;4683.274092515598;4686.156491831435;5283.365996080495;5339.893202135935;5439.619226654097;5445.346558413015;5499.972500137554;1401.9859801401856;1417.7731562950084;1429.3353590580223;1436.5977526292445;1437.978430323546;906.3293163059288;915.33638112368;931.4504442379028;931.7437704631145;941.2093841173447;4571.291449825282;4629.583337499574;4630.86107416778;4631.305304204397;4638.165130276515;5500.972495137578;5517.2551705520045;5532.225488431623;5578.358488773762;5578.497935185853;4513.187626227245;4581.404417425713;4590.609798167193;4623.42207224097;4631.930521042187;2941.2352788275202;2942.367391010943;2958.76329893608;2976.913426599319;2980.985095074511;5102.132637451642;5112.974435127875;5116.795328186905;5121.718305493234;5133.307003554547;5442.183672449164;5443.891122177534;5484.232207490954;5553.501294184638;5604.607677462538;5062.696238225718;5083.694978301313;5097.209932460474;5105.289727941181;5129.8717532062;5451.318585176853;5460.535854452416;5471.781128754806;5478.753456094565;5488.746221678071;5148.76830542619;5388.703621300866;5388.757505912165;5404.243405923253;5418.647787893774;5067.32778183206;5112.130937740519;5135.35808023997;5146.713321669583;5161.793528258828;3964.7819369933777;3966.643002129822;3975.085730282109;4020.698447616382;4026.5772093929713;5225.764840582106;5456.0451920914475;5460;5462.426445223195;5497.780088796403;5277.366715994105;5285.339332583427;5299.788008479618;5341.973290133525;5366.7584958677735;5147.382314122329;5243.764030618708;5332.73336333174;5341.679499230058;5367.838964831061;5284.894302113859;5390.730463476889;5399.70301633414;5418.83743487696;5446.264754258124;5261.763220655156;5380.623356365017;5521.404939678345;5522.520811888485;5537.1140617501005;5386.7575959082715;5394.460553944574;5395.649282796762;5401.162819762943;5406.810761623325 07:02:18 INFO - PROCESS | 9820 | |5;yui.html;645.486837963819;656.6683824668543;662.5958165519036;686.5160062156181;746.0078096132145;10691.625793097224;12006.81989770153;13058.804117938238;13122.081454298203;14381.280935953213;14349;15128.54614361571;15145.394184232646;15197.164155971444;15236.923815380907;780.9101953275389;800.9719659811908;803.3894240377326;810.1048341582555;810.8135128920352;787.8896954426385;789.4276649429175;795.2802713544252;796.1680044353665;796.2674339607574;847.3094428041157;847.8050048488851;848.9405741598091;850.1286181663783;850.4684572142411;823.5347028928666;829.4774292195938;832.8709050097215;838.8909441772561;841.7264389073575;592.2182718811171;605.4339192854695;607.6263098194622;615.8983767678328;616.2358675242712;13355.465781368734;13580.86419135806;13588.456461741518;13613.251271180081;13633.659158521017;13328;13989.30053497321;13989.510367137204;14087.295635218197;14151.221682807442;10386.896131038668;10439.895601044043;10537.104346130589;10573.312734672221;10578.894211057945;3373.342198271338;3437.9312413751586;3441.8451169697423;3445.638207988175;3447.7586568940183;58205.70897145529;58499.41500584982;59620.701896490675;59987;60085.6995715023;10500.474976251156;10794.946025269823;10844.186685998424;11001.61494347694;11180.105591552656;17581.560460988578;18154.18306176225;18224;19235.13441895118;19283.614327713647;7325.2308507607;7350.63246837656;7365.48441609093;7384.704611815575;7491.745078080454;3815.4849095372324;3854.325493038707;3876.4379165020914;3932.410138479194;4026.59734026595;3059.5104783234574;3153.1486498645695;3155.8106513609255;3163.557102005721;3172.7461803056162;523.1159340714181;525.5454032262065;525.8133362656203;535.4056996733623;541.1584985347744;615.1756646094166;615.5506480269429;626.114048621205;631.9115323854664;652.4845372155944;7941.801454963556;8130.959345203354;8173.305269052078;8224.588770561448;8619.138086191331;561.9578531610146;643.1349834472627;650.9316521765242;656.7734131724548;669.3039239191187;3994.4208089827393;4026;4127.607877251657;4131.9173616527505;4193.503636615835;61649.38350616436;87756.56121719479;88159.55920220359;88990;91147.5442622796;76984;77968;78360.60819695865;79310.6034469824;80082;43376.78311608422;44464;67538.66230668913;69891.30108698847;71258;7738.419618528746;7753.844923101619;7816.84366312682;7954.443188976948;7998.600069996593;43734.56265437432;43796.34305485484;43933.340999884385;44348;44465.333020005375;36667;39034.80482597569;39649;39936.80031599823;55352.44647553473;9223.21602663781;9481.525923703924;9906.752331191778;9931.205503559553;10100.343477673927;11337.829932551183;11383.601573944872;11640.126990475917;11679.649610511698;11985.161038727205;10871.402072886067;10991.340519568852;11051.115910726961;11276.661700149009;11635.941820290844;10894.50974706156;10910.072643825046;11072.501737421997;11179.10567154642;11521.711957201138;10783.730406739895;10884.51019704131;10897.509612067317;10950.671479855617;10986.890131098906;8949.642014319354;9104.317176211678;9159.313051521296;9162.541872906462;9261.490618016074;9373.531323433665;9678.854817177607;9814.165795907427;9851.704448866545;9867.111959923353 07:02:18 INFO - PROCESS | 9820 | __end_tp_report 07:02:18 INFO - PROCESS | 9820 | __start_cc_report 07:02:18 INFO - PROCESS | 9820 | _x_x_mozilla_cycle_collect,397 07:02:18 INFO - PROCESS | 9820 | __end_cc_report 07:02:18 INFO - PROCESS | 9820 | __startTimestamp1466604138195__endTimestamp 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | ------- Summary: start ------- 07:02:18 INFO - PROCESS | 9820 | Number of tests: 6 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#0] dojo.html Cycles:165 Average:4912.70 Median:5086.42 stddev:641.18 (12.6%) stddev-sans-first:617.73 07:02:18 INFO - PROCESS | 9820 | Values: 2634.5 2655.0 2667.0 2700.4 2701.5 4920.0 4963.6 4973.9 4975.0 4976.0 4836.5 4922.2 4950.1 4950.4 4982.7 4475.8 4504.1 4609.0 4617.5 4639.2 544.5 4491.5 4523.1 4605.4 4657.6 4519.6 4534.0 4560.9 4564.3 4605.1 4471.0 4563.0 4581.2 4586.1 4619.4 4498.4 4550.7 4595.4 4600.7 4601.1 4997.3 5023.8 5063.5 5086.4 5105.4 5308.8 5371.2 5427.9 5432.3 5447.6 5414.1 5427.9 5431.8 5432.3 5465.7 5040.7 5053.1 5055.9 5056.3 5098.4 5371.4 5450.8 5506.3 5523.5 5554.9 5222.8 5241.2 5262.7 5263.5 5265.8 5383.1 5385.9 5395.4 5398.3 5440.1 5216.1 5281.6 5333.6 5340.0 5355.3 5245.7 5249.5 5268.4 5298.9 5301.3 4535.0 4544.8 4547.7 4557.4 4603.9 3856.1 3929.1 3942.9 3947.5 3976.1 4591.9 4601.8 4602.4 4608.5 4633.9 5206.8 5422.6 5439.9 5449.2 5450.2 4526.8 4572.1 4572.3 4579.8 4586.2 4844.3 4855.3 4855.9 4867.1 4931.1 4868.6 4966.9 5029.5 5036.9 5100.1 5367.5 5389.3 5403.3 5427.1 5454.9 5049.1 5059.7 5070.3 5084.5 5126.1 5132.7 5213.1 5252.5 5316.2 5322.8 5353.1 5358.8 5371.1 5380.1 5383.7 5154.4 5175.0 5175.4 5189.2 5238.6 5072.5 5135.8 5177.8 5180.1 5225.3 4959.0 5123.5 5125.4 5137.8 5140.6 5259.4 5271.4 5278.2 5285.1 5336.5 4997.2 5107.3 5121.9 5167.0 5180.7 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#1] ext.html Cycles:180 Average:47728.97 Median:20508.50 stddev:86157.84 (420.1%) stddev-sans-first:86326.75 07:02:18 INFO - PROCESS | 9820 | Values: 560.1 572.9 592.7 597.5 617.9 35283.5 39023.8 39049.2 39157.0 39169.2 39575.6 40034.2 40121.4 40132.6 40265.0 7708.3 7867.2 7867.3 7870.7 7887.0 7770.7 7854.8 7876.0 7898.8 7901.6 7888.7 7907.2 7924.6 7929.9 7959.9 7759.7 7838.5 7840.5 7863.2 7873.3 7653.6 7740.9 7749.6 7760.3 7761.4 37550.8 37576.8 37676.2 37721.4 37820.8 3107.7 3276.9 3361.4 3444.0 3519.0 29459.7 29799.3 29951.7 29958.1 30060.8 3575.7 3581.7 3658.7 3727.7 3737.2 254433.0 255825.0 257122.0 257210.0 257403.7 45708.5 51693.0 53145.0 53494.5 57880.4 55482.4 55722.7 55888.4 55920.0 55965.7 13668.5 13753.4 13760.9 13780.0 13781.0 11005.6 11017.0 11061.4 11112.3 11374.4 15873.2 16104.4 16110.7 16133.7 16169.0 5866.1 5981.0 6084.8 6104.5 6123.2 830.8 899.5 912.9 937.7 982.6 27616.4 28253.2 28386.0 28664.3 28779.1 927.4 960.8 972.9 992.2 1022.1 14223.4 14328.4 14478.8 14567.9 14644.1 369151.0 373532.0 373831.0 373849.0 374301.0 48809.0 48815.3 48865.8 49053.8 49085.8 1151.0 1202.2 1216.9 1222.1 1229.2 26468.9 27277.3 27302.9 27320.7 27653.4 41481.4 42053.4 42116.4 42225.4 42451.4 340950.0 341042.0 341117.0 341909.0 342649.0 24465.4 24743.5 24940.9 24958.0 25016.4 42245.6 42254.6 42863.1 43039.8 43563.0 36427.8 36438.6 36703.3 36846.0 37142.4 36062.5 36076.0 36655.0 36883.8 37289.3 35500.5 35816.5 36079.5 36360.3 36412.5 31929.2 32818.0 32933.3 33491.3 33709.0 25252.0 25324.5 25375.5 25792.2 26060.7 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#2] jquery.html Cycles:180 Average:24650.14 Median:4474.86 stddev:66469.65 (1485.4%) stddev-sans-first:66631.11 07:02:18 INFO - PROCESS | 9820 | Values: 371.2 376.3 376.3 393.4 397.4 15925.1 16437.3 17112.7 17187.6 17342.8 13189.4 13872.7 14728.7 14734.7 15200.2 4697.9 4858.8 4867.9 4895.1 4895.6 3496.4 5376.6 5619.4 5625.0 5706.8 5664.7 5671.6 5683.1 5713.5 5802.3 6102.8 6231.0 6242.9 6248.2 6269.2 5313.6 5483.8 5529.9 5532.9 5548.0 13040.2 13066.7 17645.3 20419.7 20617.6 1887.2 1902.4 1913.6 1937.1 1994.9 9494.6 9682.0 10320.5 11327.6 13703.6 1726.5 1759.8 1794.2 1803.9 1814.9 69610.3 70476.6 70536.0 70571.6 71144.6 9911.7 10242.6 10326.2 10461.0 10612.7 14356.7 14389.7 14443.8 14444.9 14509.1 7044.5 7504.7 7619.0 7751.5 7811.3 7239.4 7300.7 7345.0 7363.9 7480.1 4282.7 4389.6 4473.5 4476.2 4538.1 1693.8 1750.5 1874.1 1921.3 1925.4 837.1 843.9 873.6 885.7 932.8 16459.4 16794.5 16965.2 16972.6 17188.7 854.8 858.7 865.8 881.9 883.7 9185.0 9625.7 9637.4 9669.4 9808.3 380214.0 398260.0 405163.0 405559.0 423254.0 76624.6 78407.0 78512.6 78666.6 78735.2 874.8 892.9 911.1 913.9 918.7 15104.5 15308.2 15503.2 15527.5 15805.6 34272.0 34380.3 34776.3 36150.1 36502.1 47487.8 52235.5 53292.5 53484.7 54228.5 7900.2 7974.8 8023.7 8175.2 8287.3 8900.0 11680.7 12260.7 12374.6 12382.4 10051.3 10218.8 10369.6 10672.5 10920.4 10291.7 10499.5 10569.7 10612.5 10742.9 6149.5 9434.8 9976.0 10393.8 10509.6 7406.9 7712.2 7762.2 7883.3 8133.9 9694.3 10093.0 10235.8 10385.4 10956.9 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#3] mootools.html Cycles:180 Average:5190.48 Median:4982.43 stddev:2923.11 (58.7%) stddev-sans-first:2917.10 07:02:18 INFO - PROCESS | 9820 | Values: 1354.1 1400.8 1475.7 1643.3 1694.2 6848.2 7514.6 7600.9 8112.1 8113.1 7650.2 7746.7 7862.4 7871.9 7873.3 2166.8 2217.5 2224.9 2229.0 2230.4 2182.6 2212.6 2250.2 2256.9 2262.3 2206.8 2223.6 2224.8 2239.5 2264.7 2159.8 2187.1 2207.8 2223.1 2224.1 2200.7 2227.7 2231.1 2236.6 2236.8 7821.2 7876.4 7877.0 7877.9 7899.2 4734.6 4877.9 4880.5 4884.1 4897.1 2911.9 2983.5 3091.1 3100.8 3115.1 955.6 982.8 986.4 986.7 1013.8 10850.8 10853.0 10864.2 10866.8 10902.8 4266.9 4411.3 4414.1 4457.8 4508.4 9299.7 9325.1 9340.1 9343.5 9347.7 4693.1 4700.1 4708.2 4716.5 4728.7 3780.6 4213.3 4261.6 4348.4 4395.5 3685.1 3705.9 3787.2 3804.5 3810.8 1160.0 1179.5 1206.7 1229.1 1230.1 729.2 766.6 823.5 835.5 840.2 4919.3 4995.4 5007.9 5077.3 5192.3 853.4 889.0 891.1 892.1 903.1 3338.4 3410.6 3477.9 3506.1 3516.9 9377.0 9698.7 9701.7 9866.3 9898.9 9799.5 9833.6 9835.3 9842.6 9866.7 7230.7 7331.9 7365.3 7458.7 7503.7 4834.6 4897.8 4932.0 4969.5 5019.8 9071.3 9087.5 9092.1 9135.6 9148.6 8973.6 9276.6 9309.6 9318.4 9354.3 5847.7 6220.2 6460.7 6491.5 6603.2 7749.1 7749.8 7757.8 7811.1 7828.1 6805.3 7030.7 7127.1 7165.8 7252.2 6950.4 6971.8 7020.8 7023.9 7085.5 6021.2 6049.8 6098.9 6100.1 6110.7 4331.4 4361.4 4386.4 4394.3 4430.0 4423.6 4510.5 4544.1 4564.4 4669.7 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#4] prototype.html Cycles:180 Average:4464.49 Median:5104.09 stddev:1288.85 (25.3%) stddev-sans-first:1254.20 07:02:18 INFO - PROCESS | 9820 | Values: 311.0 311.6 313.2 319.0 319.8 5187.9 5232.2 5244.9 5251.8 5252.2 5102.9 5120.8 5133.2 5142.0 5146.8 3790.7 3878.7 3985.7 3985.9 3994.6 3993.8 4009.9 4023.2 4027.1 4031.5 4008.1 4018.5 4020.5 4057.4 4059.8 3734.5 3960.5 3971.0 4038.0 4062.6 3439.6 3455.5 3457.1 3459.2 3480.8 5039.3 5039.7 5068.7 5074.8 5102.6 4336.3 4559.7 4584.1 4602.3 4641.9 5384.6 5423.8 5472.3 5485.2 5497.9 3723.7 3761.4 3806.3 3809.2 3817.9 5375.5 5734.2 5750.2 5755.6 5771.9 3973.8 3987.6 3991.2 4016.1 4024.7 4070.5 4079.4 4093.5 4095.4 4108.4 4664.0 4672.9 4674.9 4683.3 4686.2 5283.4 5339.9 5439.6 5445.3 5500.0 1402.0 1417.8 1429.3 1436.6 1438.0 906.3 915.3 931.5 931.7 941.2 4571.3 4629.6 4630.9 4631.3 4638.2 5501.0 5517.3 5532.2 5578.4 5578.5 4513.2 4581.4 4590.6 4623.4 4631.9 2941.2 2942.4 2958.8 2976.9 2981.0 5102.1 5113.0 5116.8 5121.7 5133.3 5442.2 5443.9 5484.2 5553.5 5604.6 5062.7 5083.7 5097.2 5105.3 5129.9 5451.3 5460.5 5471.8 5478.8 5488.7 5148.8 5388.7 5388.8 5404.2 5418.6 5067.3 5112.1 5135.4 5146.7 5161.8 3964.8 3966.6 3975.1 4020.7 4026.6 5225.8 5456.0 5460.0 5462.4 5497.8 5277.4 5285.3 5299.8 5342.0 5366.8 5147.4 5243.8 5332.7 5341.7 5367.8 5284.9 5390.7 5399.7 5418.8 5446.3 5261.8 5380.6 5521.4 5522.5 5537.1 5386.8 5394.5 5395.6 5401.2 5406.8 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - PROCESS | 9820 | [#5] yui.html Cycles:180 Average:16099.41 Median:538.28 stddev:21946.41 (4077.1%) stddev-sans-first:21977.29 07:02:18 INFO - PROCESS | 9820 | Values: 645.5 656.7 662.6 686.5 746.0 10691.6 12006.8 13058.8 13122.1 14381.3 14349.0 15128.5 15145.4 15197.2 15236.9 780.9 801.0 803.4 810.1 810.8 787.9 789.4 795.3 796.2 796.3 847.3 847.8 848.9 850.1 850.5 823.5 829.5 832.9 838.9 841.7 592.2 605.4 607.6 615.9 616.2 13355.5 13580.9 13588.5 13613.3 13633.7 13328.0 13989.3 13989.5 14087.3 14151.2 10386.9 10439.9 10537.1 10573.3 10578.9 3373.3 3437.9 3441.8 3445.6 3447.8 58205.7 58499.4 59620.7 59987.0 60085.7 10500.5 10794.9 10844.2 11001.6 11180.1 17581.6 18154.2 18224.0 19235.1 19283.6 7325.2 7350.6 7365.5 7384.7 7491.7 3815.5 3854.3 3876.4 3932.4 4026.6 3059.5 3153.1 3155.8 3163.6 3172.7 523.1 525.5 525.8 535.4 541.2 615.2 615.6 626.1 631.9 652.5 7941.8 8131.0 8173.3 8224.6 8619.1 562.0 643.1 650.9 656.8 669.3 3994.4 4026.0 4127.6 4131.9 4193.5 61649.4 87756.6 88159.6 88990.0 91147.5 76984.0 77968.0 78360.6 79310.6 80082.0 43376.8 44464.0 67538.7 69891.3 71258.0 7738.4 7753.8 7816.8 7954.4 7998.6 43734.6 43796.3 43933.3 44348.0 44465.3 36667.0 39034.8 39649.0 39936.8 55352.4 9223.2 9481.5 9906.8 9931.2 10100.3 11337.8 11383.6 11640.1 11679.6 11985.2 10871.4 10991.3 11051.1 11276.7 11635.9 10894.5 10910.1 11072.5 11179.1 11521.7 10783.7 10884.5 10897.5 10950.7 10986.9 8949.6 9104.3 9159.3 9162.5 9261.5 9373.5 9678.9 9814.2 9851.7 9867.1 07:02:18 INFO - PROCESS | 9820 | -------- Summary: end -------- 07:02:18 INFO - PROCESS | 9820 | 07:02:18 INFO - TEST-INFO | 9820: exit 0 07:02:18 INFO - TEST-OK | dromaeo_css | took 1117576ms 07:02:18 INFO - TEST-START | kraken 07:02:18 INFO - operating with platform_type : linux_ 07:02:18 INFO - Initialising browser for kraken test... 07:02:19 INFO - TEST-INFO | started process 10062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbX9Cwy/profile http://localhost:37440/getInfo.html) 07:02:24 INFO - PROCESS | 10062 | __metrics Screen width/height:1600/1200 07:02:24 INFO - PROCESS | 10062 | colorDepth:24 07:02:24 INFO - PROCESS | 10062 | Browser inner width/height: 1024/697 07:02:24 INFO - PROCESS | 10062 | __metrics 07:02:25 ERROR - PROCESS | 10062 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:02:26 INFO - TEST-INFO | 10062: exit 0 07:02:26 INFO - Browser initialized. 07:02:26 INFO - Running cycle 1/1 for kraken test... 07:02:26 INFO - TEST-INFO | started process 10184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbX9Cwy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:38 INFO - PROCESS | 10184 | RSS: Main: 186306560 07:02:38 INFO - PROCESS | 10184 | 07:02:41 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37440/tests/kraken/driver.html?testName=audio-beat-detection) 07:02:42 INFO - PROCESS | 10184 | RSS: Main: 191176704 07:02:42 INFO - PROCESS | 10184 | 07:02:44 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37440/tests/kraken/driver.html?testName=audio-dft) 07:02:45 INFO - PROCESS | 10184 | RSS: Main: 190676992 07:02:45 INFO - PROCESS | 10184 | 07:02:48 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37440/tests/kraken/driver.html?testName=audio-fft) 07:02:49 INFO - PROCESS | 10184 | RSS: Main: 186720256 07:02:49 INFO - PROCESS | 10184 | 07:02:51 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37440/tests/kraken/driver.html?testName=audio-oscillator) 07:02:51 INFO - PROCESS | 10184 | RSS: Main: 186966016 07:02:51 INFO - PROCESS | 10184 | 07:02:54 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:02:54 INFO - PROCESS | 10184 | RSS: Main: 187383808 07:02:54 INFO - PROCESS | 10184 | 07:02:58 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37440/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:58 INFO - PROCESS | 10184 | RSS: Main: 187727872 07:02:58 INFO - PROCESS | 10184 | 07:03:02 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37440/tests/kraken/driver.html?testName=imaging-desaturate) 07:03:02 INFO - PROCESS | 10184 | RSS: Main: 184778752 07:03:02 INFO - PROCESS | 10184 | 07:03:05 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37440/tests/kraken/driver.html?testName=json-parse-financial) 07:03:06 INFO - PROCESS | 10184 | RSS: Main: 186044416 07:03:06 INFO - PROCESS | 10184 | 07:03:08 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:03:08 INFO - PROCESS | 10184 | RSS: Main: 187183104 07:03:08 INFO - PROCESS | 10184 | 07:03:10 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:03:11 INFO - PROCESS | 10184 | RSS: Main: 187420672 07:03:11 INFO - PROCESS | 10184 | 07:03:13 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:03:14 INFO - PROCESS | 10184 | RSS: Main: 187547648 07:03:14 INFO - PROCESS | 10184 | 07:03:17 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:03:17 INFO - PROCESS | 10184 | RSS: Main: 187572224 07:03:17 INFO - PROCESS | 10184 | 07:03:20 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:03:21 INFO - PROCESS | 10184 | RSS: Main: 187506688 07:03:21 INFO - PROCESS | 10184 | 07:03:22 INFO - PROCESS | 10184 | Cycle 1(1): loaded http://localhost:37440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37440/tests/kraken/driver.html?testName=ai-astar) 07:03:23 INFO - PROCESS | 10184 | RSS: Main: 188342272 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | __start_tp_report 07:03:23 INFO - PROCESS | 10184 | _x_x_mozilla_page_load 07:03:23 INFO - PROCESS | 10184 | _x_x_mozilla_page_load_details 07:03:23 INFO - PROCESS | 10184 | |i|pagename|runs| 07:03:23 INFO - PROCESS | 10184 | |0;ai-astar;105;115;109;117;117;114;117;113;114;115 07:03:23 INFO - PROCESS | 10184 | |1;audio-beat-detection;163;150;158;186;132;159;160;133;190;133 07:03:23 INFO - PROCESS | 10184 | |2;audio-dft;163;162;164;170;164;165;162;167;163;159 07:03:23 INFO - PROCESS | 10184 | |3;audio-fft;75;75;74;160;78;79;75;76;158;76 07:03:23 INFO - PROCESS | 10184 | |4;audio-oscillator;86;86;141;86;89;86;132;87;92;140 07:03:23 INFO - PROCESS | 10184 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;121;117 07:03:23 INFO - PROCESS | 10184 | |6;imaging-darkroom;148;148;149;148;149;147;147;147;147;147 07:03:23 INFO - PROCESS | 10184 | |7;imaging-desaturate;96;96;95;96;95;97;96;96;96;96 07:03:23 INFO - PROCESS | 10184 | |8;json-parse-financial;70;66;66;65;65;63;66;63;64;64 07:03:23 INFO - PROCESS | 10184 | |9;json-stringify-tinderbox;65;65;65;66;66;65;65;65;65;65 07:03:23 INFO - PROCESS | 10184 | |10;stanford-crypto-aes;83;82;83;84;85;83;83;83;98;89 07:03:23 INFO - PROCESS | 10184 | |11;stanford-crypto-ccm;131;132;131;138;135;145;127;139;134;132 07:03:23 INFO - PROCESS | 10184 | |12;stanford-crypto-pbkdf2;172;174;169;167;166;166;168;167;168;167 07:03:23 INFO - PROCESS | 10184 | |13;stanford-crypto-sha256-iterative;69;69;68;70;69;66;68;66;68;68 07:03:23 INFO - PROCESS | 10184 | __end_tp_report 07:03:23 INFO - PROCESS | 10184 | __start_cc_report 07:03:23 INFO - PROCESS | 10184 | _x_x_mozilla_cycle_collect,981 07:03:23 INFO - PROCESS | 10184 | __end_cc_report 07:03:23 INFO - PROCESS | 10184 | __startTimestamp1466604203187__endTimestamp 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | ------- Summary: start ------- 07:03:23 INFO - PROCESS | 10184 | Number of tests: 14 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.86 (3.4%) stddev-sans-first:2.55 07:03:23 INFO - PROCESS | 10184 | Values: 105.0 115.0 109.0 117.0 117.0 114.0 117.0 113.0 114.0 115.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:159.50 stddev:20.55 (12.9%) stddev-sans-first:21.66 07:03:23 INFO - PROCESS | 10184 | Values: 163.0 150.0 158.0 186.0 132.0 159.0 160.0 133.0 190.0 133.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:3.00 (1.8%) stddev-sans-first:3.16 07:03:23 INFO - PROCESS | 10184 | Values: 163.0 162.0 164.0 170.0 164.0 165.0 162.0 167.0 163.0 159.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.50 stddev:35.03 (46.4%) stddev-sans-first:36.57 07:03:23 INFO - PROCESS | 10184 | Values: 75.0 75.0 74.0 160.0 78.0 79.0 75.0 76.0 158.0 76.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:86.00 stddev:24.45 (28.4%) stddev-sans-first:25.19 07:03:23 INFO - PROCESS | 10184 | Values: 86.0 86.0 141.0 86.0 89.0 86.0 132.0 87.0 92.0 140.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 07:03:23 INFO - PROCESS | 10184 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 121.0 117.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 07:03:23 INFO - PROCESS | 10184 | Values: 148.0 148.0 149.0 148.0 149.0 147.0 147.0 147.0 147.0 147.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:03:23 INFO - PROCESS | 10184 | Values: 96.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:2.04 (3.1%) stddev-sans-first:1.22 07:03:23 INFO - PROCESS | 10184 | Values: 70.0 66.0 66.0 65.0 65.0 63.0 66.0 63.0 64.0 64.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:03:23 INFO - PROCESS | 10184 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:83.50 stddev:4.88 (5.8%) stddev-sans-first:5.10 07:03:23 INFO - PROCESS | 10184 | Values: 83.0 82.0 83.0 84.0 85.0 83.0 83.0 83.0 98.0 89.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:134.50 stddev:5.13 (3.8%) stddev-sans-first:5.29 07:03:23 INFO - PROCESS | 10184 | Values: 131.0 132.0 131.0 138.0 135.0 145.0 127.0 139.0 134.0 132.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.00 stddev:2.63 (1.6%) stddev-sans-first:2.45 07:03:23 INFO - PROCESS | 10184 | Values: 172.0 174.0 169.0 167.0 166.0 166.0 168.0 167.0 168.0 167.0 07:03:23 INFO - PROCESS | 10184 | 07:03:23 INFO - PROCESS | 10184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 07:03:23 INFO - PROCESS | 10184 | Values: 69.0 69.0 68.0 70.0 69.0 66.0 68.0 66.0 68.0 68.0 07:03:23 INFO - PROCESS | 10184 | -------- Summary: end -------- 07:03:23 INFO - PROCESS | 10184 | 07:03:24 INFO - TEST-INFO | 10184: exit 0 07:03:24 INFO - TEST-OK | kraken | took 65251ms 07:03:24 INFO - SUITE-END | took 1182s 07:03:24 INFO - Completed test suite (00:19:42) 07:03:24 INFO - javascript benchmark 07:03:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6523.794289670578, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.5126151661943, 2654.9911033807152, 2667.0398656483662, 2700.3519155402696, 2701.4732127235184, 4919.999999999995, 4963.578095861856, 4973.880876802727, 4974.975125124374, 4975.950240497598, 4836.492168322319, 4922.1878390065685, 4950.059488697145, 4950.430700469438, 4982.725950072744, 4475.753833539154, 4504.144212599612, 4608.976955115219, 4617.538246175389, 4639.211334073216, 544.4546396681307, 4491.483479399878, 4523.140603285382, 4605.378273933026, 4657.5575320344515, 4519.638428925678, 4534.025184585314, 4560.88597785058, 4564.338170965225, 4605.125026245037, 4470.977645111786, 4563.041761230145, 4581.221192397267, 4586.105709386671, 4619.422572178478, 4498.415206023229, 4550.68145229834, 4595.379623750784, 4600.746958917258, 4601.056783359437, 4997.30037794709, 5023.773930173114, 5063.54428101469, 5086.41506226785, 5105.387353517564, 5308.761105750251, 5371.221172929942, 5427.891442171174, 5432.320959880015, 5447.591430642718, 5414.07960646691, 5427.891442171134, 5431.755570999315, 5432.266644003088, 5465.672059676433, 5040.697558146523, 5053.065182941167, 5055.9241611375855, 5056.292119103328, 5098.413682426494, 5371.409144994048, 5450.754716037788, 5506.339239291311, 5523.502884740312, 5554.888902221933, 5222.764975576109, 5241.24002019705, 5262.710550919736, 5263.526282634504, 5265.76304066318, 5383.111786555253, 5385.946140538623, 5395.406505284415, 5398.325209348832, 5440.129579267298, 5216.061109000417, 5281.603879709037, 5333.626646134733, 5339.985402773461, 5355.3305836770405, 5245.7114858683135, 5249.501297376743, 5268.394134674485, 5298.947010529922, 5301.257823904656, 4535.047639995571, 4544.772761361919, 4547.658925580595, 4557.407537020233, 4603.861884143481, 3856.1130939883983, 3929.096307849211, 3942.8817135485406, 3947.486826712509, 3976.1252524444576, 4591.885202869888, 4601.7699115044115, 4602.4477062752685, 4608.539146085432, 4633.860984170413, 5206.76569554371, 5422.593305502103, 5439.864003399867, 5449.209864569615, 5450.236966824647, 4526.79629416677, 4572.1312950539295, 4572.268437050056, 4579.771011449414, 4586.197415452282, 4844.32179494871, 4855.295982082578, 4855.902881942412, 4867.050925069578, 4931.137051016058, 4868.586170175433, 4966.8758281043265, 5029.5221953914315, 5036.924446133237, 5100.081985242692, 5367.490088441592, 5389.326334208224, 5403.270558474713, 5427.1316589345515, 5454.863628409322, 5049.065922804146, 5059.663487942425, 5070.3155074064525, 5084.466131056186, 5126.102931986962, 5132.717700526507, 5213.061648903234, 5252.474752524717, 5316.229146773773, 5322.760475778677, 5353.116735738559, 5358.839234822962, 5371.140617501337, 5380.11228147367, 5383.67697938125, 5154.433012368711, 5174.96500699854, 5175.37895452533, 5189.221616757516, 5238.633295669419, 5072.492750724898, 5135.794568217229, 5177.792888284426, 5180.119379705535, 5225.268462415341, 4958.975205123951, 5123.513266239701, 5125.359330083739, 5137.8201762938115, 5140.640155189101, 5259.421463639073, 5271.367435907716, 5278.2346559749385, 5285.101532739367, 5336.546393556591, 4997.225430058346, 5107.284980102863, 5121.873187898656, 5167.0, 5180.7409629519125], "value": 4871.320230615287, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1449557729027, 572.8739677271001, 592.6947621974684, 597.5488506177835, 617.8887800195963, 35283.4707479388, 39023.80488097563, 39049.219015619674, 39156.99999999993, 39169.21661566767, 39575.604243957554, 40034.199316013735, 40121.39817902727, 40132.59867401325, 40265.0, 7708.344790692798, 7867.1739467355965, 7867.331276841475, 7870.685172593089, 7886.960565197166, 7770.689172433096, 7854.842903141934, 7876.015498062742, 7898.80252993674, 7901.644426000844, 7888.723894663688, 7907.16974717655, 7924.564148971805, 7929.881051784228, 7959.880601790977, 7759.728409505668, 7838.451308408414, 7840.4511684182135, 7863.213678632148, 7873.25204105609, 7653.579053152074, 7740.8838867417035, 7749.573773442458, 7760.262775036363, 7761.379089672812, 37550.81224593887, 37576.812115939516, 37676.24647507062, 37721.43417848735, 37820.810895945346, 3107.735842453394, 3276.9016929492154, 3361.3949489091956, 3443.9655603443894, 3519.0, 29459.70540294591, 29799.25501862449, 29951.700482995107, 29958.10125696211, 30060.8496957516, 3575.66031227033, 3581.6776490116013, 3658.652428019334, 3727.7390582659223, 3737.2338670572467, 254433.0, 255825.0, 257122.0, 257210.0, 257403.71298143576, 45708.542914571095, 51693.0, 53145.0, 53494.46505534973, 57880.421195788345, 55482.445175548535, 55722.72138639281, 55888.441115589136, 55920.0, 55965.7201713997, 13668.52160174389, 13753.38109785062, 13760.93119534396, 13780.0, 13781.0, 11005.61480348184, 11017.0, 11061.391623460788, 11112.333260004425, 11374.431278436045, 15873.206339682969, 16104.436344727877, 16110.67778644444, 16133.67732645364, 16169.029858208545, 5866.05150021723, 5981.0, 6084.847878803065, 6104.542159338067, 6123.173371594867, 830.7507747675673, 899.4827973915025, 912.8539433690711, 937.7421209167534, 982.6216906491053, 27616.447671046466, 28253.15240542787, 28386.0, 28664.283392915346, 28779.136625901258, 927.3647551427159, 960.8030353777459, 972.9464879431699, 992.2437286003733, 1022.0648106982177, 14223.431062757581, 14328.426862925366, 14478.782818257734, 14567.854321456862, 14644.12135271887, 369151.0, 373532.0, 373831.0, 373849.0, 374301.0, 48809.0, 48815.26777098346, 48865.75567122213, 49053.754731226116, 49085.75457122691, 1150.9597164099384, 1202.2185579373477, 1216.853977522703, 1222.0529089955355, 1229.1764517773113, 26468.867655661597, 27277.318067048483, 27302.863485682443, 27320.726792731817, 27653.446931060862, 41481.37777933273, 42053.36919946142, 42116.36825447682, 42225.36661950012, 42451.3632295522, 340950.0, 341042.0, 341117.0, 341909.0, 342649.0, 24465.3883652903, 24743.50512989766, 24940.875295623406, 24958.0, 25016.37459063538, 42245.577544224165, 42254.577454225066, 42863.14273714446, 43039.784801075795, 43563.0, 36427.81786091052, 36438.63561364352, 36703.265934681694, 36846.0, 37142.44286335761, 36062.45906311355, 36076.0, 36655.0, 36883.815580922994, 37289.254214916094, 35500.467492988144, 35816.4627530582, 36079.45880811843, 36360.27279454449, 36412.4538131923, 31929.201769955936, 32818.0, 32933.34133317368, 33491.330173396884, 33709.0, 25252.0, 25324.493510129327, 25375.492490149725, 25792.226233213034, 26060.739392605832], "value": 17494.467940148224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.21488052768393, 376.3019598644514, 376.31135022908063, 393.4177417422213, 397.4415945596438, 15925.12411817351, 16437.260323285453, 17112.74330885038, 17187.570310742238, 17342.82657173428, 13189.406476708547, 13872.722545549082, 14728.705425891476, 14734.705305893876, 15200.239988000583, 4697.929531057045, 4858.833879868824, 4867.9269810952865, 4895.069936712013, 4895.55939965403, 3496.4230901901155, 5376.569874410038, 5619.353774315945, 5625.0, 5706.800261990831, 5664.745086471119, 5671.602987790856, 5683.119116536944, 5713.542916566665, 5802.332731735841, 6102.847428814293, 6231.034189700558, 6242.906356404635, 6248.218972628421, 6269.247690277173, 5313.57491400687, 5483.7806487740445, 5529.861753456155, 5532.944670553283, 5547.972260138714, 13040.152390094709, 13066.673333166651, 17645.294188232456, 20419.693704594443, 20617.58764824695, 1887.2356695538328, 1902.4387805597244, 1913.5885784556249, 1937.118611031977, 1994.9301774437824, 9494.572744226458, 9682.0, 10320.535575899103, 11327.603533876274, 13703.588892333146, 1726.4647959132583, 1759.7536344911723, 1794.1657129434745, 1803.9007854567994, 1814.8548116150807, 69610.30389696089, 70476.6476167621, 70536.0, 70571.64714176448, 71144.64427677829, 9911.65309214174, 10242.59029638821, 10326.22553308505, 10461.006204410569, 10612.734681632866, 14356.712865742627, 14389.712205755826, 14443.78334324986, 14444.855551444562, 14509.129452232688, 7044.450220951382, 7504.699812007568, 7618.961905190438, 7751.534907905544, 7811.336036436853, 7239.420846332281, 7300.671469783872, 7344.96327518359, 7363.889541656772, 7480.0649918760155, 4282.657387409, 4389.582989615981, 4473.485549161823, 4476.239039363316, 4538.069695712371, 1693.7544056111794, 1750.544858336816, 1874.147262995334, 1921.2603147788202, 1925.3935010471657, 837.1475559254158, 843.8776377425239, 873.5675840458887, 885.6944354197791, 932.8414169591185, 16459.423920162735, 16794.53713537068, 16965.236564354633, 16972.575685607957, 17188.656226875642, 854.811941372897, 858.6908712863365, 865.8311629232365, 881.8809460722721, 883.7186080183759, 9185.007735689056, 9625.71122866315, 9637.37357071788, 9669.419834809934, 9808.313418060667, 380214.0, 398260.0, 405163.0, 405559.0, 423254.0, 76624.61687691526, 78407.0, 78512.60743696245, 78666.6066669663, 78735.21264787394, 874.7681864305964, 892.901780804111, 911.0570559471048, 913.9451632902047, 918.7289749523907, 15104.471343502924, 15308.158051307286, 15503.224838758242, 15527.456539021532, 15805.604859878595, 34272.0, 34380.31239375148, 34776.30447391089, 36150.09624759402, 36502.087447812955, 47487.76256118697, 52235.47764522306, 53292.4670753303, 53484.73257633687, 54228.457715422344, 7900.209979002054, 7974.8006299840645, 8023.6790528378215, 8175.182481751777, 8287.295579875537, 8900.0, 11680.70798230051, 12260.693482663004, 12374.566890159162, 12382.442790074288, 10051.296409251283, 10218.846717299099, 10369.63706270277, 10672.519736611715, 10920.399378033966, 10291.742706432398, 10499.527521261714, 10569.735756606146, 10612.522436490222, 10742.89257107419, 6149.508039356751, 9434.764130896783, 9976.0, 10393.844092338772, 10509.579616815241, 7406.888896666662, 7712.228777122243, 7762.223777622193, 7883.251091146332, 8133.877991830009, 9694.321397502106, 10093.0, 10235.84646230322, 10385.376877387382, 10956.945215273872], "value": 8258.495730158571, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.05216348556, 1400.7688731359326, 1475.6532214929496, 1643.3180230204466, 1694.2121913310316, 6848.246692863781, 7514.624268786566, 7600.885986710196, 8112.1076681565055, 8113.148119447462, 7650.234976502347, 7746.651400686968, 7862.449628526006, 7871.92128078719, 7873.291403773674, 2166.815820655242, 2217.545403192342, 2224.8665080095248, 2229.0303717882693, 2230.4423894026495, 2182.552576721776, 2212.5685491329195, 2250.2011785816044, 2256.9322920312416, 2262.321303608919, 2206.79035491628, 2223.6442169252923, 2224.7997680208778, 2239.529698763262, 2264.739554951177, 2159.762426133124, 2187.103287652063, 2207.8233741300655, 2223.0885337011828, 2224.143704673696, 2200.7359116905914, 2227.6658501224783, 2231.0518029837417, 2236.563870045342, 2236.7539570647214, 7821.21787821219, 7876.409269304825, 7877.0, 7877.881831772528, 7899.210078992112, 4734.573888350065, 4877.8780530486665, 4880.487548807395, 4884.096442158212, 4897.142999975025, 2911.898083567065, 2983.4928062229474, 3091.1035799618085, 3100.767442441826, 3115.1121930249997, 955.6034245787989, 982.8280050991119, 986.3539381704994, 986.7335819328813, 1013.8327176015948, 10850.837237441445, 10853.0, 10864.185186111074, 10866.782664346747, 10902.836457453144, 4266.850660226877, 4411.250087485135, 4414.1171765647, 4457.821687132543, 4508.413906192174, 9299.72100836976, 9325.114114159143, 9340.112689294507, 9343.505039193833, 9347.672831451002, 4693.084848454587, 4700.106979673919, 4708.199606066977, 4716.528347165325, 4728.692634978715, 3780.5652349979555, 4213.262679031157, 4261.552536983572, 4348.412964249849, 4395.450568678915, 3685.1155722626377, 3705.925881482355, 3787.223619158121, 3804.4673745675627, 3810.7523011004196, 1160.0255785140523, 1179.5281887245171, 1206.6621346023128, 1229.1088960503564, 1230.1143176912608, 729.2488736601309, 766.5707203965796, 823.5223570329194, 835.4820011592851, 840.1976112812249, 4919.311296418504, 4995.375578052744, 5007.924881126786, 5077.31456253401, 5192.324997750268, 853.38129855854, 888.9688860889838, 891.0910870911633, 892.125716797542, 903.051795614602, 3338.382399256145, 3410.6248312685584, 3477.8608855646, 3506.088417011544, 3516.909757975036, 9376.95311523438, 9698.739163908647, 9701.70894873155, 9866.30935834499, 9898.901010989943, 9799.510024498746, 9833.557489912972, 9835.262355323379, 9842.606295748234, 9866.703998880044, 7230.674619642129, 7331.926680733124, 7365.329470247946, 7458.701651933862, 7503.662335194929, 4834.613230941586, 4897.804087836446, 4931.9753401232765, 4969.47820478859, 5019.824306149268, 9071.274298056007, 9087.545622718706, 9092.090790920854, 9135.588898499716, 9148.588313525774, 8973.596188171417, 9276.58255378523, 9309.581068851783, 9318.394304370195, 9354.345195836226, 5847.707614619337, 6220.222472190976, 6460.676966151767, 6491.545591808528, 6603.174603174603, 7749.070111586646, 7749.845003100019, 7757.806054848674, 7811.140774514685, 7828.13890472059, 6805.2854450283985, 7030.718771249298, 7127.144742630918, 7165.820854478679, 7252.238514955854, 6950.443964482728, 6971.79084627462, 7020.7542736004, 7023.859522809617, 7085.504014719127, 6021.187139736079, 6049.818505444844, 6098.908516372169, 6100.1459795629535, 6110.694465276807, 4331.350297455407, 4361.389405483298, 4386.429764130643, 4394.318880573516, 4430.0, 4423.579759922803, 4510.458744950627, 4544.136614043321, 4564.356831540709, 4669.696469729457], "value": 4183.492580050108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9751219902408, 311.61204300645693, 313.17009923702193, 319.04923328481124, 319.8145075856001, 5187.910538786855, 5232.16285394337, 5244.947550524494, 5251.816186433475, 5252.238425428315, 5102.897942041157, 5120.769565369558, 5133.1786914093755, 5141.974290128554, 5146.768395422206, 3790.734648574594, 3878.747881387715, 3985.7409268397605, 3985.9202815943663, 3994.5805690402526, 3993.760374377532, 4009.939850902239, 4023.215472982755, 4027.1140349123148, 4031.496062992126, 4008.118213992917, 4018.5177778666457, 4020.5376381716037, 4057.431959525669, 4059.776712280823, 3734.514513113278, 3960.4653371794725, 3970.980145099285, 4037.97981010096, 4062.6343629073376, 3439.6044454887756, 3455.4989526518766, 3457.1184347991352, 3459.1697992481877, 3480.8085555294447, 5039.319691841628, 5039.672421292641, 5068.695878247317, 5074.797008119708, 5102.591792656579, 4336.34954756789, 4559.658025648089, 4584.106099310636, 4602.309653551961, 4641.86074417768, 5384.623076384654, 5423.783048678088, 5472.26124473195, 5485.204645326446, 5497.890042199134, 3723.6834869035893, 3761.37937240355, 3806.3148633246283, 3809.2381523695094, 3817.866374676873, 5375.516203541661, 5734.197212390269, 5750.1949727038245, 5755.597108202427, 5771.855703607402, 3973.7814420206587, 3987.5613682494904, 3991.1818077294083, 4016.136530645925, 4024.7461421603994, 4070.531888832763, 4079.3676980068135, 4093.5087789465456, 4095.365218391154, 4108.43222985634, 4664.0, 4672.883177920579, 4674.883127921761, 4683.274092515598, 4686.156491831435, 5283.365996080495, 5339.893202135935, 5439.619226654097, 5445.346558413015, 5499.972500137554, 1401.9859801401856, 1417.7731562950084, 1429.3353590580223, 1436.5977526292445, 1437.978430323546, 906.3293163059288, 915.33638112368, 931.4504442379028, 931.7437704631145, 941.2093841173447, 4571.291449825282, 4629.583337499574, 4630.86107416778, 4631.305304204397, 4638.165130276515, 5500.972495137578, 5517.2551705520045, 5532.225488431623, 5578.358488773762, 5578.497935185853, 4513.187626227245, 4581.404417425713, 4590.609798167193, 4623.42207224097, 4631.930521042187, 2941.2352788275202, 2942.367391010943, 2958.76329893608, 2976.913426599319, 2980.985095074511, 5102.132637451642, 5112.974435127875, 5116.795328186905, 5121.718305493234, 5133.307003554547, 5442.183672449164, 5443.891122177534, 5484.232207490954, 5553.501294184638, 5604.607677462538, 5062.696238225718, 5083.694978301313, 5097.209932460474, 5105.289727941181, 5129.8717532062, 5451.318585176853, 5460.535854452416, 5471.781128754806, 5478.753456094565, 5488.746221678071, 5148.76830542619, 5388.703621300866, 5388.757505912165, 5404.243405923253, 5418.647787893774, 5067.32778183206, 5112.130937740519, 5135.35808023997, 5146.713321669583, 5161.793528258828, 3964.7819369933777, 3966.643002129822, 3975.085730282109, 4020.698447616382, 4026.5772093929713, 5225.764840582106, 5456.0451920914475, 5460.0, 5462.426445223195, 5497.780088796403, 5277.366715994105, 5285.339332583427, 5299.788008479618, 5341.973290133525, 5366.7584958677735, 5147.382314122329, 5243.764030618708, 5332.73336333174, 5341.679499230058, 5367.838964831061, 5284.894302113859, 5390.730463476889, 5399.70301633414, 5418.83743487696, 5446.264754258124, 5261.763220655156, 5380.623356365017, 5521.404939678345, 5522.520811888485, 5537.1140617501005, 5386.7575959082715, 5394.460553944574, 5395.649282796762, 5401.162819762943, 5406.810761623325], "value": 4056.179442995841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.486837963819, 656.6683824668543, 662.5958165519036, 686.5160062156181, 746.0078096132145, 10691.625793097224, 12006.81989770153, 13058.804117938238, 13122.081454298203, 14381.280935953213, 14349.0, 15128.54614361571, 15145.394184232646, 15197.164155971444, 15236.923815380907, 780.9101953275389, 800.9719659811908, 803.3894240377326, 810.1048341582555, 810.8135128920352, 787.8896954426385, 789.4276649429175, 795.2802713544252, 796.1680044353665, 796.2674339607574, 847.3094428041157, 847.8050048488851, 848.9405741598091, 850.1286181663783, 850.4684572142411, 823.5347028928666, 829.4774292195938, 832.8709050097215, 838.8909441772561, 841.7264389073575, 592.2182718811171, 605.4339192854695, 607.6263098194622, 615.8983767678328, 616.2358675242712, 13355.465781368734, 13580.86419135806, 13588.456461741518, 13613.251271180081, 13633.659158521017, 13328.0, 13989.30053497321, 13989.510367137204, 14087.295635218197, 14151.221682807442, 10386.896131038668, 10439.895601044043, 10537.104346130589, 10573.312734672221, 10578.894211057945, 3373.342198271338, 3437.9312413751586, 3441.8451169697423, 3445.638207988175, 3447.7586568940183, 58205.70897145529, 58499.41500584982, 59620.701896490675, 59987.0, 60085.6995715023, 10500.474976251156, 10794.946025269823, 10844.186685998424, 11001.61494347694, 11180.105591552656, 17581.560460988578, 18154.18306176225, 18224.0, 19235.13441895118, 19283.614327713647, 7325.2308507607, 7350.63246837656, 7365.48441609093, 7384.704611815575, 7491.745078080454, 3815.4849095372324, 3854.325493038707, 3876.4379165020914, 3932.410138479194, 4026.59734026595, 3059.5104783234574, 3153.1486498645695, 3155.8106513609255, 3163.557102005721, 3172.7461803056162, 523.1159340714181, 525.5454032262065, 525.8133362656203, 535.4056996733623, 541.1584985347744, 615.1756646094166, 615.5506480269429, 626.114048621205, 631.9115323854664, 652.4845372155944, 7941.801454963556, 8130.959345203354, 8173.305269052078, 8224.588770561448, 8619.138086191331, 561.9578531610146, 643.1349834472627, 650.9316521765242, 656.7734131724548, 669.3039239191187, 3994.4208089827393, 4026.0, 4127.607877251657, 4131.9173616527505, 4193.503636615835, 61649.38350616436, 87756.56121719479, 88159.55920220359, 88990.0, 91147.5442622796, 76984.0, 77968.0, 78360.60819695865, 79310.6034469824, 80082.0, 43376.78311608422, 44464.0, 67538.66230668913, 69891.30108698847, 71258.0, 7738.419618528746, 7753.844923101619, 7816.84366312682, 7954.443188976948, 7998.600069996593, 43734.56265437432, 43796.34305485484, 43933.340999884385, 44348.0, 44465.333020005375, 36667.0, 39034.80482597569, 39649.0, 39936.80031599823, 55352.44647553473, 9223.21602663781, 9481.525923703924, 9906.752331191778, 9931.205503559553, 10100.343477673927, 11337.829932551183, 11383.601573944872, 11640.126990475917, 11679.649610511698, 11985.161038727205, 10871.402072886067, 10991.340519568852, 11051.115910726961, 11276.661700149009, 11635.941820290844, 10894.50974706156, 10910.072643825046, 11072.501737421997, 11179.10567154642, 11521.711957201138, 10783.730406739895, 10884.51019704131, 10897.509612067317, 10950.671479855617, 10986.890131098906, 8949.642014319354, 9104.317176211678, 9159.313051521296, 9162.541872906462, 9261.490618016074, 9373.531323433665, 9678.854817177607, 9814.165795907427, 9851.704448866545, 9867.111959923353], "value": 6454.338279439251, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 109.0, 117.0, 117.0, 114.0, 117.0, 113.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 150.0, 158.0, 186.0, 132.0, 159.0, 160.0, 133.0, 190.0, 133.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 170.0, 164.0, 165.0, 162.0, 167.0, 163.0, 159.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 160.0, 78.0, 79.0, 75.0, 76.0, 158.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 141.0, 86.0, 89.0, 86.0, 132.0, 87.0, 92.0, 140.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 121.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 66.0, 65.0, 65.0, 63.0, 66.0, 63.0, 64.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 85.0, 83.0, 83.0, 83.0, 98.0, 89.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 131.0, 138.0, 135.0, 145.0, 127.0, 139.0, 134.0, 132.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 167.0, 166.0, 166.0, 168.0, 167.0, 168.0, 167.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 69.0, 66.0, 68.0, 66.0, 68.0, 68.0], "value": 68.1, "unit": "score"}]}]} 07:03:24 INFO - Return code: 0 07:03:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:03:24 ERROR - # TBPL SUCCESS # 07:03:24 INFO - Running post-action listener: _resource_record_post_action 07:03:24 INFO - ##### 07:03:24 INFO - ##### Finished run-tests step (success) 07:03:24 INFO - ##### 07:03:24 INFO - Running post-run listener: _resource_record_post_run 07:03:24 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 155648; Write bytes: 360865792; Read time: 780; Write time: 419136 07:03:24 INFO - TinderboxPrint: CPU usage
13.5% 07:03:24 INFO - TinderboxPrint: I/O read bytes / time
155,648 / 780 07:03:24 INFO - TinderboxPrint: I/O write bytes / time
360,865,792 / 419,136 07:03:24 INFO - TinderboxPrint: CPU idle
8,283.9 (86.5%) 07:03:24 INFO - TinderboxPrint: CPU user
1,231.9 (12.9%) 07:03:24 INFO - TinderboxPrint: Swap in / out
0 / 0 07:03:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 70451200; Read time: 368; Write time: 63284 07:03:24 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 151552; Write bytes: 290414592; Read time: 412; Write time: 355852 07:03:25 INFO - Running post-run listener: _upload_blobber_files 07:03:25 INFO - Blob upload gear active. 07:03:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:03:25 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 07:03:25 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:03:25 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:03:25 INFO - (blobuploader) - INFO - Open directory for files ... 07:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:26 INFO - (blobuploader) - INFO - Done attempting. 07:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:30 INFO - (blobuploader) - INFO - Done attempting. 07:03:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:03:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:31 INFO - (blobuploader) - INFO - Done attempting. 07:03:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:03:31 INFO - Return code: 0 07:03:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:03:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:03:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2ec5961e61f9cd86c5fc47b44fdd37dc59cbfaef282d61a55f6f0c6593e3fdf9282ad954ec0a694a50e509e76574a4855d0fa30702d7e8a773551aa75c0345a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f74370f05a7900e6d98b149906049238fbcfbdf81f8d4035132738927416f000634b579289755fee0ade21b41daa177059d7c6503372fae7601dac000042175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d469872f5e72e6451bdcc3c58a66da73de38307b8f2e59f09d2dfcb325448d027ce160c1792ef873e67027a7d8ae6dbb3a901812ef64a6719898bec6ed1bf9b7"} 07:03:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:03:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:03:31 INFO - Contents: 07:03:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2ec5961e61f9cd86c5fc47b44fdd37dc59cbfaef282d61a55f6f0c6593e3fdf9282ad954ec0a694a50e509e76574a4855d0fa30702d7e8a773551aa75c0345a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f74370f05a7900e6d98b149906049238fbcfbdf81f8d4035132738927416f000634b579289755fee0ade21b41daa177059d7c6503372fae7601dac000042175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d469872f5e72e6451bdcc3c58a66da73de38307b8f2e59f09d2dfcb325448d027ce160c1792ef873e67027a7d8ae6dbb3a901812ef64a6719898bec6ed1bf9b7"} 07:03:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:03:31 INFO - Copying logs to upload dir... 07:03:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:03:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.347216 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-22 07:03:31.425964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:03:31.430020) ========= 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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2ec5961e61f9cd86c5fc47b44fdd37dc59cbfaef282d61a55f6f0c6593e3fdf9282ad954ec0a694a50e509e76574a4855d0fa30702d7e8a773551aa75c0345a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f74370f05a7900e6d98b149906049238fbcfbdf81f8d4035132738927416f000634b579289755fee0ade21b41daa177059d7c6503372fae7601dac000042175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d469872f5e72e6451bdcc3c58a66da73de38307b8f2e59f09d2dfcb325448d027ce160c1792ef873e67027a7d8ae6dbb3a901812ef64a6719898bec6ed1bf9b7"} build_url:https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/d_DWxpo-Rv-363zBNByo5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2ec5961e61f9cd86c5fc47b44fdd37dc59cbfaef282d61a55f6f0c6593e3fdf9282ad954ec0a694a50e509e76574a4855d0fa30702d7e8a773551aa75c0345a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f74370f05a7900e6d98b149906049238fbcfbdf81f8d4035132738927416f000634b579289755fee0ade21b41daa177059d7c6503372fae7601dac000042175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d469872f5e72e6451bdcc3c58a66da73de38307b8f2e59f09d2dfcb325448d027ce160c1792ef873e67027a7d8ae6dbb3a901812ef64a6719898bec6ed1bf9b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:03:31.455787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:03:31.456175) ========= 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=8783db0840cc980e80bb0bd400000236-1466602936.466326-1766926945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:03:31.539691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:03:31.540095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:03:31.540447) ========= ========= Total master_lag: 0.17 =========