builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1465299349.27 results: success (0) buildid: 20160607034831 builduid: b0e3dba0691843099c31577b6543c7db revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.272755) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.273371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.273703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.289594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.290025) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 04:35:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-07 04:35:49 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.423006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.423363) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014990 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.474004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:49.474426) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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 d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 04:35:49,974 truncating revision to first 12 chars 2016-06-07 04:35:49,975 Setting DEBUG logging. 2016-06-07 04:35:49,975 attempt 1/10 2016-06-07 04:35:49,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6e0d9a0319f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 04:35:50,296 unpacking tar archive at: fx-team-d6e0d9a0319f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706339 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:50.206008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:50.206724) ========= script_repo_revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:50.207607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:50.208188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 04:35:50.280987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 04:35:50.281705) ========= /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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:35:50 INFO - MultiFileLogger online at 20160607 04:35:50 in /builds/slave/test 04:35:50 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 04:35:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:50 INFO - {'append_to_log': False, 04:35:50 INFO - 'base_work_dir': '/builds/slave/test', 04:35:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:35:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:50 INFO - 'branch': 'Fx-Team-Non-PGO', 04:35:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:50 INFO - 'config_files': ('talos/linux_config.py',), 04:35:50 INFO - 'default_actions': ('clobber', 04:35:50 INFO - 'read-buildbot-config', 04:35:50 INFO - 'download-and-extract', 04:35:50 INFO - 'populate-webroot', 04:35:50 INFO - 'create-virtualenv', 04:35:50 INFO - 'install', 04:35:50 INFO - 'run-tests'), 04:35:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:50 INFO - 'download_minidump_stackwalk': True, 04:35:50 INFO - 'download_symbols': 'ondemand', 04:35:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:50 INFO - 'installer_path': 'installer.exe', 04:35:50 INFO - 'log_level': 'info', 04:35:50 INFO - 'log_name': 'talos', 04:35:50 INFO - 'log_to_console': True, 04:35:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:35:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:35:50 INFO - 'opt_config_files': (), 04:35:50 INFO - 'pip_index': False, 04:35:50 INFO - 'sps_profile': False, 04:35:50 INFO - 'sps_profile_interval': 0, 04:35:50 INFO - 'suite': 'dromaeojs-e10s', 04:35:50 INFO - 'system_bits': '32', 04:35:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:50 INFO - 'title': 'talos-linux64-ix-004', 04:35:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:50 INFO - 'use_talos_json': True, 04:35:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:50 INFO - 'work_dir': 'build'} 04:35:50 INFO - ##### 04:35:50 INFO - ##### Running clobber step. 04:35:50 INFO - ##### 04:35:50 INFO - Running pre-action listener: _resource_record_pre_action 04:35:50 INFO - Running main action method: clobber 04:35:50 INFO - rmtree: /builds/slave/test/build 04:35:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:51 INFO - Running post-action listener: _resource_record_post_action 04:35:51 INFO - ##### 04:35:51 INFO - ##### Finished clobber step (success) 04:35:51 INFO - ##### 04:35:51 INFO - ##### 04:35:51 INFO - ##### Running read-buildbot-config step. 04:35:51 INFO - ##### 04:35:51 INFO - Running pre-action listener: _resource_record_pre_action 04:35:51 INFO - Running main action method: read_buildbot_config 04:35:51 INFO - Using buildbot properties: 04:35:51 INFO - { 04:35:51 INFO - "project": "", 04:35:51 INFO - "product": "firefox", 04:35:51 INFO - "script_repo_revision": "production", 04:35:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:35:51 INFO - "repository": "", 04:35:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:35:51 INFO - "buildid": "20160607034831", 04:35:51 INFO - "pgo_build": "False", 04:35:51 INFO - "basedir": "/builds/slave/test", 04:35:51 INFO - "buildnumber": 1376, 04:35:51 INFO - "slavename": "talos-linux64-ix-004", 04:35:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:35:51 INFO - "platform": "ubuntu64_hw", 04:35:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:35:51 INFO - "branch": "fx-team", 04:35:51 INFO - "repo_path": "integration/fx-team", 04:35:51 INFO - "revision": "d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079", 04:35:51 INFO - "stage_platform": "linux64", 04:35:51 INFO - "builduid": "b0e3dba0691843099c31577b6543c7db", 04:35:51 INFO - "slavebuilddir": "test" 04:35:51 INFO - } 04:35:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:35:51 INFO - Running post-action listener: _resource_record_post_action 04:35:51 INFO - ##### 04:35:51 INFO - ##### Finished read-buildbot-config step (success) 04:35:51 INFO - ##### 04:35:51 INFO - ##### 04:35:51 INFO - ##### Running download-and-extract step. 04:35:51 INFO - ##### 04:35:51 INFO - Running pre-action listener: _resource_record_pre_action 04:35:51 INFO - Running main action method: download_and_extract 04:35:51 INFO - mkdir: /builds/slave/test/build/tests 04:35:51 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')]} 04:35:51 INFO - https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:52 INFO - Downloaded 1361 bytes. 04:35:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:52 INFO - Using the following test package requirements: 04:35:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:35:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:35:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:35:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'jsshell-linux-x86_64.zip'], 04:35:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:35:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:35:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:35:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:35:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:35:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:35:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:52 INFO - https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:53 INFO - Downloaded 22871657 bytes. 04:35:53 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'] 04:35:53 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 04:35:54 INFO - Return code: 0 04:35:54 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 04:35:54 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')]} 04:35:54 INFO - https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:55 INFO - Downloaded 22871657 bytes. 04:35:55 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'] 04:35:55 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 04:35:56 INFO - Return code: 0 04:35:56 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')]} 04:35:56 INFO - https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:57 INFO - Downloaded 10833369 bytes. 04:35:57 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'] 04:35:57 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 04:35:57 INFO - Return code: 0 04:35:57 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')]} 04:35:57 INFO - https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNTBiOedQJGKsDNpcRWBqA/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 04:35:59 INFO - Downloaded 55206526 bytes. 04:35:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:59 INFO - mkdir: /builds/slave/test/properties 04:35:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:59 INFO - Contents: 04:35:59 INFO - build_url:https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:36:00 INFO - Running post-action listener: _resource_record_post_action 04:36:00 INFO - Running post-action listener: set_extra_try_arguments 04:36:00 INFO - ##### 04:36:00 INFO - ##### Finished download-and-extract step (success) 04:36:00 INFO - ##### 04:36:00 INFO - ##### 04:36:00 INFO - ##### Running populate-webroot step. 04:36:00 INFO - ##### 04:36:00 INFO - Running pre-action listener: _resource_record_pre_action 04:36:00 INFO - Running main action method: populate_webroot 04:36:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:00 INFO - '--tppagecycles', 04:36:00 INFO - '7'], 04:36:00 INFO - 'tests': ['tsvgm']}}, 04:36:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['damp', 'tps']}, 04:36:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'tests': ['damp', 'tps']}, 04:36:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['dromaeo_dom']}, 04:36:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['a11yr', 04:36:00 INFO - 'ts_paint', 04:36:00 INFO - 'tpaint', 04:36:00 INFO - 'sessionrestore', 04:36:00 INFO - 'sessionrestore_no_auto_restore', 04:36:00 INFO - 'tabpaint']}, 04:36:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['tsvgx', 04:36:00 INFO - 'tsvgr_opacity', 04:36:00 INFO - 'tart', 04:36:00 INFO - 'tscrollx', 04:36:00 INFO - 'cart']}, 04:36:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:00 INFO - 'tsvgr_opacity', 04:36:00 INFO - 'tart', 04:36:00 INFO - 'tscrollx', 04:36:00 INFO - 'cart']}, 04:36:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'talos_options': ['--disable-e10s'], 04:36:00 INFO - 'tests': ['tp5o']}, 04:36:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'tests': ['tp5o']}, 04:36:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'talos_options': ['--disable-e10s', 04:36:00 INFO - '--xperf_path', 04:36:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:00 INFO - 'tests': ['tp5n']}, 04:36:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:00 INFO - 'talos_options': ['--xperf_path', 04:36:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:00 INFO - 'tests': ['tp5n']}}, 04:36:00 INFO - 'talos.zip': {'path': '', 04:36:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:00 INFO - Running post-action listener: _resource_record_post_action 04:36:00 INFO - ##### 04:36:00 INFO - ##### Finished populate-webroot step (success) 04:36:00 INFO - ##### 04:36:00 INFO - ##### 04:36:00 INFO - ##### Running create-virtualenv step. 04:36:00 INFO - ##### 04:36:00 INFO - Running pre-action listener: _resource_record_pre_action 04:36:00 INFO - Running main action method: create_virtualenv 04:36:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:00 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 04:36:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:00 INFO - Using real prefix '/usr' 04:36:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:02 INFO - Installing pip.................done. 04:36:02 INFO - Return code: 0 04:36:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:02 INFO - Using env: {'DISPLAY': ':0', 04:36:02 INFO - 'HOME': '/home/cltbld', 04:36:02 INFO - 'LANG': 'en_US.UTF-8', 04:36:02 INFO - 'LANGUAGE': 'en_US:en', 04:36:02 INFO - 'LOGNAME': 'cltbld', 04:36:02 INFO - 'MAIL': '/var/mail/cltbld', 04:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:02 INFO - 'MOZ_NO_REMOTE': '1', 04:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:02 INFO - 'NO_EM_RESTART': '1', 04:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:02 INFO - 'PWD': '/builds/slave/test', 04:36:02 INFO - 'SHELL': '/bin/bash', 04:36:02 INFO - 'SHLVL': '1', 04:36:02 INFO - 'TERM': 'linux', 04:36:02 INFO - 'TMOUT': '86400', 04:36:02 INFO - 'USER': 'cltbld', 04:36:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:02 INFO - '_': '/tools/buildbot/bin/python'} 04:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:02 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 04:36:02 INFO - Cleaning up... 04:36:03 INFO - Return code: 0 04:36:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:36:03 INFO - Using env: {'DISPLAY': ':0', 04:36:03 INFO - 'HOME': '/home/cltbld', 04:36:03 INFO - 'LANG': 'en_US.UTF-8', 04:36:03 INFO - 'LANGUAGE': 'en_US:en', 04:36:03 INFO - 'LOGNAME': 'cltbld', 04:36:03 INFO - 'MAIL': '/var/mail/cltbld', 04:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:03 INFO - 'MOZ_NO_REMOTE': '1', 04:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:03 INFO - 'NO_EM_RESTART': '1', 04:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:03 INFO - 'PWD': '/builds/slave/test', 04:36:03 INFO - 'SHELL': '/bin/bash', 04:36:03 INFO - 'SHLVL': '1', 04:36:03 INFO - 'TERM': 'linux', 04:36:03 INFO - 'TMOUT': '86400', 04:36:03 INFO - 'USER': 'cltbld', 04:36:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:03 INFO - '_': '/tools/buildbot/bin/python'} 04:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:03 INFO - Downloading/unpacking psutil>=3.1.1 04:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:05 INFO - Installing collected packages: psutil 04:36:05 INFO - Running setup.py install for psutil 04:36:05 INFO - building 'psutil._psutil_linux' extension 04:36:05 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 04:36:05 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 04:36:05 INFO - building 'psutil._psutil_posix' extension 04:36:05 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 04:36:05 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 04:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:05 INFO - Successfully installed psutil 04:36:05 INFO - Cleaning up... 04:36:05 INFO - Return code: 0 04:36:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:05 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')]} 04:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:05 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')]} 04:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:05 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:05 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 04:36:05 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 04:36:05 INFO - Using env: {'DISPLAY': ':0', 04:36:05 INFO - 'HOME': '/home/cltbld', 04:36:05 INFO - 'LANG': 'en_US.UTF-8', 04:36:05 INFO - 'LANGUAGE': 'en_US:en', 04:36:05 INFO - 'LOGNAME': 'cltbld', 04:36:05 INFO - 'MAIL': '/var/mail/cltbld', 04:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:05 INFO - 'MOZ_NO_REMOTE': '1', 04:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:05 INFO - 'NO_EM_RESTART': '1', 04:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:05 INFO - 'PWD': '/builds/slave/test', 04:36:05 INFO - 'SHELL': '/bin/bash', 04:36:05 INFO - 'SHLVL': '1', 04:36:05 INFO - 'TERM': 'linux', 04:36:05 INFO - 'TMOUT': '86400', 04:36:05 INFO - 'USER': 'cltbld', 04:36:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:05 INFO - '_': '/tools/buildbot/bin/python'} 04:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:06 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 04:36:06 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 04:36:06 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 04:36:06 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 04:36:06 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 04:36:06 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 04:36:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:07 INFO - Installing collected packages: mozsystemmonitor 04:36:07 INFO - Running setup.py install for mozsystemmonitor 04:36:08 INFO - Successfully installed mozsystemmonitor 04:36:08 INFO - Cleaning up... 04:36:08 INFO - Return code: 0 04:36:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:08 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')]} 04:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:08 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')]} 04:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:08 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:08 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 04:36:08 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 04:36:08 INFO - Using env: {'DISPLAY': ':0', 04:36:08 INFO - 'HOME': '/home/cltbld', 04:36:08 INFO - 'LANG': 'en_US.UTF-8', 04:36:08 INFO - 'LANGUAGE': 'en_US:en', 04:36:08 INFO - 'LOGNAME': 'cltbld', 04:36:08 INFO - 'MAIL': '/var/mail/cltbld', 04:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:08 INFO - 'MOZ_NO_REMOTE': '1', 04:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:08 INFO - 'NO_EM_RESTART': '1', 04:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:08 INFO - 'PWD': '/builds/slave/test', 04:36:08 INFO - 'SHELL': '/bin/bash', 04:36:08 INFO - 'SHLVL': '1', 04:36:08 INFO - 'TERM': 'linux', 04:36:08 INFO - 'TMOUT': '86400', 04:36:08 INFO - 'USER': 'cltbld', 04:36:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:08 INFO - '_': '/tools/buildbot/bin/python'} 04:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:08 INFO - Downloading/unpacking jsonschema==2.5.1 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:10 INFO - warning: no files found matching '*.txt' 04:36:10 INFO - no previously-included directories found matching 'build' 04:36:10 INFO - no previously-included directories found matching 'dist' 04:36:10 INFO - no previously-included directories found matching '.git*' 04:36:10 INFO - Installing collected packages: jsonschema, functools32 04:36:10 INFO - Running setup.py install for functools32 04:36:10 INFO - warning: no files found matching '*.txt' 04:36:10 INFO - no previously-included directories found matching 'build' 04:36:10 INFO - no previously-included directories found matching 'dist' 04:36:10 INFO - no previously-included directories found matching '.git*' 04:36:10 INFO - Successfully installed jsonschema functools32 04:36:10 INFO - Cleaning up... 04:36:10 INFO - Return code: 0 04:36:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:10 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')]} 04:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:10 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')]} 04:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:10 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:10 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 04:36:10 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 04:36:10 INFO - Using env: {'DISPLAY': ':0', 04:36:10 INFO - 'HOME': '/home/cltbld', 04:36:10 INFO - 'LANG': 'en_US.UTF-8', 04:36:10 INFO - 'LANGUAGE': 'en_US:en', 04:36:10 INFO - 'LOGNAME': 'cltbld', 04:36:10 INFO - 'MAIL': '/var/mail/cltbld', 04:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:10 INFO - 'MOZ_NO_REMOTE': '1', 04:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:10 INFO - 'NO_EM_RESTART': '1', 04:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:10 INFO - 'PWD': '/builds/slave/test', 04:36:10 INFO - 'SHELL': '/bin/bash', 04:36:10 INFO - 'SHLVL': '1', 04:36:10 INFO - 'TERM': 'linux', 04:36:10 INFO - 'TMOUT': '86400', 04:36:10 INFO - 'USER': 'cltbld', 04:36:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:10 INFO - '_': '/tools/buildbot/bin/python'} 04:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:10 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 04:36:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 INFO - Downloading docopt-0.6.1.tar.gz 04:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:14 INFO - Running setup.py install for blobuploader 04:36:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:14 INFO - Running setup.py install for requests 04:36:14 INFO - Running setup.py install for docopt 04:36:15 INFO - Successfully installed blobuploader requests docopt 04:36:15 INFO - Cleaning up... 04:36:15 INFO - Return code: 0 04:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:15 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')]} 04:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:15 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')]} 04:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:15 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:15 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 04:36:15 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 04:36:15 INFO - Using env: {'DISPLAY': ':0', 04:36:15 INFO - 'HOME': '/home/cltbld', 04:36:15 INFO - 'LANG': 'en_US.UTF-8', 04:36:15 INFO - 'LANGUAGE': 'en_US:en', 04:36:15 INFO - 'LOGNAME': 'cltbld', 04:36:15 INFO - 'MAIL': '/var/mail/cltbld', 04:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:15 INFO - 'MOZ_NO_REMOTE': '1', 04:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:15 INFO - 'NO_EM_RESTART': '1', 04:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:15 INFO - 'PWD': '/builds/slave/test', 04:36:15 INFO - 'SHELL': '/bin/bash', 04:36:15 INFO - 'SHLVL': '1', 04:36:15 INFO - 'TERM': 'linux', 04:36:15 INFO - 'TMOUT': '86400', 04:36:15 INFO - 'USER': 'cltbld', 04:36:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:15 INFO - '_': '/tools/buildbot/bin/python'} 04:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:15 INFO - Running setup.py (path:/tmp/pip-dWVorg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:15 INFO - Running setup.py (path:/tmp/pip-jeOyMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:15 INFO - Running setup.py (path:/tmp/pip-Bn5TZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:15 INFO - Running setup.py (path:/tmp/pip-kogQZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:15 INFO - Running setup.py (path:/tmp/pip-ZIa11z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:15 INFO - Running setup.py (path:/tmp/pip-SArdrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:15 INFO - Running setup.py (path:/tmp/pip-zPSoiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:15 INFO - Running setup.py (path:/tmp/pip-x7_KLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:15 INFO - Running setup.py (path:/tmp/pip-NdeCY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:15 INFO - Running setup.py (path:/tmp/pip-Mu3Ljg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:16 INFO - Running setup.py (path:/tmp/pip-MSf1Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:16 INFO - Running setup.py (path:/tmp/pip-5CBJYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:16 INFO - Running setup.py (path:/tmp/pip-pbeAKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:16 INFO - Running setup.py (path:/tmp/pip-ykCy8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:16 INFO - Running setup.py (path:/tmp/pip-SxYiO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:16 INFO - Running setup.py (path:/tmp/pip-47NpS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:16 INFO - Running setup.py (path:/tmp/pip-wGVRXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:16 INFO - Running setup.py install for manifestparser 04:36:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:16 INFO - Running setup.py install for mozcrash 04:36:16 INFO - Running setup.py install for mozdebug 04:36:16 INFO - Running setup.py install for mozdevice 04:36:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:16 INFO - Running setup.py install for mozfile 04:36:17 INFO - Running setup.py install for mozhttpd 04:36:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for mozinfo 04:36:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for mozInstall 04:36:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for mozleak 04:36:17 INFO - Running setup.py install for mozlog 04:36:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for moznetwork 04:36:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for mozprocess 04:36:17 INFO - Running setup.py install for mozprofile 04:36:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:17 INFO - Running setup.py install for mozrunner 04:36:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:18 INFO - Running setup.py install for mozscreenshot 04:36:18 INFO - Running setup.py install for moztest 04:36:18 INFO - Running setup.py install for mozversion 04:36:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:18 INFO - Cleaning up... 04:36:18 INFO - Return code: 0 04:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:18 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')]} 04:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:18 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')]} 04:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:18 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:18 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 04:36:18 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 04:36:18 INFO - Using env: {'DISPLAY': ':0', 04:36:18 INFO - 'HOME': '/home/cltbld', 04:36:18 INFO - 'LANG': 'en_US.UTF-8', 04:36:18 INFO - 'LANGUAGE': 'en_US:en', 04:36:18 INFO - 'LOGNAME': 'cltbld', 04:36:18 INFO - 'MAIL': '/var/mail/cltbld', 04:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:18 INFO - 'MOZ_NO_REMOTE': '1', 04:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:18 INFO - 'NO_EM_RESTART': '1', 04:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:18 INFO - 'PWD': '/builds/slave/test', 04:36:18 INFO - 'SHELL': '/bin/bash', 04:36:18 INFO - 'SHLVL': '1', 04:36:18 INFO - 'TERM': 'linux', 04:36:18 INFO - 'TMOUT': '86400', 04:36:18 INFO - 'USER': 'cltbld', 04:36:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:18 INFO - '_': '/tools/buildbot/bin/python'} 04:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:18 INFO - Running setup.py (path:/tmp/pip-_PE0O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:18 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)) 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:18 INFO - Running setup.py (path:/tmp/pip-F9_9KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:18 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)) 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:18 INFO - Running setup.py (path:/tmp/pip-5LCxE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:18 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)) 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:18 INFO - Running setup.py (path:/tmp/pip-JoLnLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:18 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)) 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:18 INFO - Running setup.py (path:/tmp/pip-Eb7WEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:18 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)) 04:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:18 INFO - Running setup.py (path:/tmp/pip-PUKjZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:19 INFO - Running setup.py (path:/tmp/pip-nZypea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:19 INFO - Running setup.py (path:/tmp/pip-KwcLvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:19 INFO - Running setup.py (path:/tmp/pip-Bl3jIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:19 INFO - Running setup.py (path:/tmp/pip-BD0YSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:19 INFO - Running setup.py (path:/tmp/pip-ePVgZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:19 INFO - Running setup.py (path:/tmp/pip-qqfMCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:19 INFO - Running setup.py (path:/tmp/pip-W1T3s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:19 INFO - Running setup.py (path:/tmp/pip-GOA4ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:19 INFO - Running setup.py (path:/tmp/pip-GhzaCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:19 INFO - Running setup.py (path:/tmp/pip-C4AN0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:19 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)) 04:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:19 INFO - Running setup.py (path:/tmp/pip-WJzIaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:19 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)) 04:36:19 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)) 04:36:19 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)) 04:36:19 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)) 04:36:19 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)) 04:36:19 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)) 04:36:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:19 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 04:36:19 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 04:36:19 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 04:36:19 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 04:36:19 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 04:36:19 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 04:36:21 INFO - Downloading blessings-1.6.tar.gz 04:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:21 INFO - Installing collected packages: blessings 04:36:21 INFO - Running setup.py install for blessings 04:36:21 INFO - Successfully installed blessings 04:36:21 INFO - Cleaning up... 04:36:21 INFO - Return code: 0 04:36:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:22 INFO - Reading from file tmpfile_stdout 04:36:22 INFO - Current package versions: 04:36:22 INFO - argparse == 1.2.1 04:36:22 INFO - blessings == 1.6 04:36:22 INFO - blobuploader == 1.2.4 04:36:22 INFO - docopt == 0.6.1 04:36:22 INFO - functools32 == 3.2.3-2 04:36:22 INFO - jsonschema == 2.5.1 04:36:22 INFO - manifestparser == 1.1 04:36:22 INFO - mozInstall == 1.12 04:36:22 INFO - mozcrash == 0.17 04:36:22 INFO - mozdebug == 0.1 04:36:22 INFO - mozdevice == 0.48 04:36:22 INFO - mozfile == 1.2 04:36:22 INFO - mozhttpd == 0.7 04:36:22 INFO - mozinfo == 0.9 04:36:22 INFO - mozleak == 0.1 04:36:22 INFO - mozlog == 3.2 04:36:22 INFO - moznetwork == 0.27 04:36:22 INFO - mozprocess == 0.22 04:36:22 INFO - mozprofile == 0.28 04:36:22 INFO - mozrunner == 6.11 04:36:22 INFO - mozscreenshot == 0.1 04:36:22 INFO - mozsystemmonitor == 0.3 04:36:22 INFO - moztest == 0.7 04:36:22 INFO - mozversion == 1.4 04:36:22 INFO - psutil == 3.1.1 04:36:22 INFO - requests == 1.2.3 04:36:22 INFO - wsgiref == 0.1.2 04:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:22 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:22 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 04:36:22 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 04:36:22 INFO - Using env: {'DISPLAY': ':0', 04:36:22 INFO - 'HOME': '/home/cltbld', 04:36:22 INFO - 'LANG': 'en_US.UTF-8', 04:36:22 INFO - 'LANGUAGE': 'en_US:en', 04:36:22 INFO - 'LOGNAME': 'cltbld', 04:36:22 INFO - 'MAIL': '/var/mail/cltbld', 04:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:22 INFO - 'MOZ_NO_REMOTE': '1', 04:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:22 INFO - 'NO_EM_RESTART': '1', 04:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:22 INFO - 'PWD': '/builds/slave/test', 04:36:22 INFO - 'SHELL': '/bin/bash', 04:36:22 INFO - 'SHLVL': '1', 04:36:22 INFO - 'TERM': 'linux', 04:36:22 INFO - 'TMOUT': '86400', 04:36:22 INFO - 'USER': 'cltbld', 04:36:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:22 INFO - '_': '/tools/buildbot/bin/python'} 04:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 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)) 04:36:22 INFO - Cleaning up... 04:36:22 INFO - Return code: 0 04:36:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:22 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:22 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 04:36:22 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 04:36:22 INFO - Using env: {'DISPLAY': ':0', 04:36:22 INFO - 'HOME': '/home/cltbld', 04:36:22 INFO - 'LANG': 'en_US.UTF-8', 04:36:22 INFO - 'LANGUAGE': 'en_US:en', 04:36:22 INFO - 'LOGNAME': 'cltbld', 04:36:22 INFO - 'MAIL': '/var/mail/cltbld', 04:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:22 INFO - 'MOZ_NO_REMOTE': '1', 04:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:22 INFO - 'NO_EM_RESTART': '1', 04:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:22 INFO - 'PWD': '/builds/slave/test', 04:36:22 INFO - 'SHELL': '/bin/bash', 04:36:22 INFO - 'SHLVL': '1', 04:36:22 INFO - 'TERM': 'linux', 04:36:22 INFO - 'TMOUT': '86400', 04:36:22 INFO - 'USER': 'cltbld', 04:36:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:22 INFO - '_': '/tools/buildbot/bin/python'} 04:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:22 INFO - Cleaning up... 04:36:22 INFO - Return code: 0 04:36:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:22 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 0x7f6ce70fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', '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 04:36:22 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 04:36:22 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 04:36:22 INFO - Using env: {'DISPLAY': ':0', 04:36:22 INFO - 'HOME': '/home/cltbld', 04:36:22 INFO - 'LANG': 'en_US.UTF-8', 04:36:22 INFO - 'LANGUAGE': 'en_US:en', 04:36:22 INFO - 'LOGNAME': 'cltbld', 04:36:22 INFO - 'MAIL': '/var/mail/cltbld', 04:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:22 INFO - 'MOZ_NO_REMOTE': '1', 04:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:22 INFO - 'NO_EM_RESTART': '1', 04:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:22 INFO - 'PWD': '/builds/slave/test', 04:36:22 INFO - 'SHELL': '/bin/bash', 04:36:22 INFO - 'SHLVL': '1', 04:36:22 INFO - 'TERM': 'linux', 04:36:22 INFO - 'TMOUT': '86400', 04:36:22 INFO - 'USER': 'cltbld', 04:36:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:22 INFO - '_': '/tools/buildbot/bin/python'} 04:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:22 INFO - Downloading/unpacking flake8 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:36:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:36:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:36:25 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 04:36:25 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 04:36:25 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 04:36:25 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 04:36:25 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 04:36:25 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 04:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:25 INFO - no previously-included directories found matching 'docs/_build' 04:36:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:36:25 INFO - Running setup.py install for pep8 04:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:25 INFO - no previously-included directories found matching 'docs/_build' 04:36:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:36:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:36:25 INFO - Cleaning up... 04:36:25 INFO - Return code: 0 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - Running post-action listener: _start_resource_monitoring 04:36:25 INFO - Starting resource monitoring. 04:36:25 INFO - ##### 04:36:25 INFO - ##### Finished create-virtualenv step (success) 04:36:25 INFO - ##### 04:36:25 INFO - ##### 04:36:25 INFO - ##### Running install step. 04:36:25 INFO - ##### 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: install 04:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:25 INFO - Reading from file tmpfile_stdout 04:36:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:25 INFO - Reading from file tmpfile_stdout 04:36:25 INFO - Output received: 04:36:25 INFO - Usage: mozinstall [options] installer 04:36:25 INFO - Options: 04:36:25 INFO - -h, --help show this help message and exit 04:36:25 INFO - -d DEST, --destination=DEST 04:36:25 INFO - Directory to install application into. [default: 04:36:25 INFO - "/builds/slave/test"] 04:36:25 INFO - --app=APP Application being installed. [default: firefox] 04:36:25 INFO - mkdir: /builds/slave/test/build/application 04:36:25 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'] 04:36:25 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 04:36:41 INFO - Reading from file tmpfile_stdout 04:36:41 INFO - Output received: 04:36:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:36:41 INFO - Running post-action listener: _resource_record_post_action 04:36:41 INFO - ##### 04:36:41 INFO - ##### Finished install step (success) 04:36:41 INFO - ##### 04:36:41 INFO - ##### 04:36:41 INFO - ##### Running run-tests step. 04:36:41 INFO - ##### 04:36:41 INFO - Running pre-action listener: _resource_record_pre_action 04:36:41 INFO - Running main action method: run_tests 04:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:41 INFO - Python 2.7.3 04:36:41 INFO - Return code: 0 04:36:41 INFO - grabbing minidump binary from tooltool 04:36:41 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')]} 04:36:41 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 0x25b6990>, '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 0x2522470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2522900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:41 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 04:36:41 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 04:36:41 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 04:36:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:41 INFO - Return code: 0 04:36:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:36:42 INFO - Return code: 0 04:36:42 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/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:36:42 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/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 04:36:42 INFO - Using env: {'DISPLAY': ':0', 04:36:42 INFO - 'HOME': '/home/cltbld', 04:36:42 INFO - 'LANG': 'en_US.UTF-8', 04:36:42 INFO - 'LANGUAGE': 'en_US:en', 04:36:42 INFO - 'LOGNAME': 'cltbld', 04:36:42 INFO - 'MAIL': '/var/mail/cltbld', 04:36:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:42 INFO - 'MOZ_NO_REMOTE': '1', 04:36:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:42 INFO - 'NO_EM_RESTART': '1', 04:36:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:42 INFO - 'PWD': '/builds/slave/test', 04:36:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:42 INFO - 'SHELL': '/bin/bash', 04:36:42 INFO - 'SHLVL': '1', 04:36:42 INFO - 'TERM': 'linux', 04:36:42 INFO - 'TMOUT': '86400', 04:36:42 INFO - 'USER': 'cltbld', 04:36:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743', 04:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:42 INFO - '_': '/tools/buildbot/bin/python'} 04:36:42 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/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:36:43 INFO - mozversion application_buildid: 20160607034831 04:36:43 INFO - mozversion application_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 04:36:43 INFO - mozversion application_display_name: Nightly 04:36:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:43 INFO - mozversion application_name: Firefox 04:36:43 INFO - mozversion application_remotingname: firefox 04:36:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:36:43 INFO - mozversion application_vendor: Mozilla 04:36:43 INFO - mozversion application_version: 50.0a1 04:36:43 INFO - mozversion platform_buildid: 20160607034831 04:36:43 INFO - mozversion platform_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 04:36:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:36:43 INFO - mozversion platform_version: 50.0a1 04:36:43 INFO - using testdate: 1465299403 04:36:43 INFO - actual date: 1465299403 04:36:43 INFO - starting webserver on 'localhost:38654' 04:36:43 INFO - SUITE-START | Running 2 tests 04:36:43 INFO - TEST-START | dromaeo_css 04:36:43 INFO - operating with platform_type : linux_ 04:36:43 INFO - Initialising browser for dromaeo_css test... 04:36:43 INFO - TEST-INFO | started process 20396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCy_ES9/profile http://localhost:38654/getInfo.html) 04:36:48 INFO - PROCESS | 20396 | __metrics Screen width/height:1600/1200 04:36:48 INFO - PROCESS | 20396 | colorDepth:24 04:36:48 INFO - PROCESS | 20396 | Browser inner width/height: 1024/697 04:36:48 INFO - PROCESS | 20396 | __metrics 04:36:49 ERROR - PROCESS | 20396 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:36:49 INFO - TEST-INFO | 20396: exit 0 04:36:49 INFO - Browser initialized. 04:36:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:49 INFO - TEST-INFO | started process 20514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCy_ES9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:01 INFO - PROCESS | 20514 | RSS: Main: 167870464 04:37:01 INFO - PROCESS | 20514 | 04:37:51 INFO - PROCESS | 20514 | 1465299471476 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] 04:40:03 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38654/tests/dromaeo/cssquery-ext.html) 04:40:04 INFO - PROCESS | 20514 | RSS: Main: 171307008 04:40:04 INFO - PROCESS | 20514 | 04:43:06 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-ext.html (next: http://localhost:38654/tests/dromaeo/cssquery-jquery.html) 04:43:07 INFO - PROCESS | 20514 | RSS: Main: 169484288 04:43:07 INFO - PROCESS | 20514 | 04:46:09 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38654/tests/dromaeo/cssquery-mootools.html) 04:46:09 INFO - PROCESS | 20514 | RSS: Main: 170192896 04:46:09 INFO - PROCESS | 20514 | 04:49:11 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38654/tests/dromaeo/cssquery-prototype.html) 04:49:12 INFO - PROCESS | 20514 | RSS: Main: 168595456 04:49:12 INFO - PROCESS | 20514 | 04:52:14 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38654/tests/dromaeo/cssquery-yui.html) 04:52:15 INFO - PROCESS | 20514 | RSS: Main: 170229760 04:52:15 INFO - PROCESS | 20514 | 04:55:17 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:38654/tests/dromaeo/cssquery-yui.html (next: http://localhost:38654/tests/dromaeo/cssquery-dojo.html) 04:55:18 INFO - PROCESS | 20514 | RSS: Main: 171565056 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | __start_tp_report 04:55:18 INFO - PROCESS | 20514 | _x_x_mozilla_page_load 04:55:18 INFO - PROCESS | 20514 | _x_x_mozilla_page_load_details 04:55:18 INFO - PROCESS | 20514 | |i|pagename|runs| 04:55:18 INFO - PROCESS | 20514 | |0;dojo.html;2671.4389978104596;2674.491846549156;2681.8390896546207;2710.471458065678;2729.2767416634583;4725.551072648097;4735.076660051292;4753.1444340018825;4759.785809638566;4822.541858523444;4584.243599806036;4673.83641572545;4678.461976872661;4733.360996265503;4762.666613337059;4267.48790145183;4276.615104640582;4358.237308471021;4367.890802729941;4377.299632058871;356.61208566651635;4277.465316835395;4304.461942257218;4311.245532031898;4319.200947824646;4296.119295544406;4299.376590394407;4335.891602709926;4338.240807858612;4372.2130016597;4330.025744207528;4331.371951067078;4334;4337.479502459725;4352.281873490871;4281.571842815724;4323.65410767141;4347.130573885235;4347.956520434786;4350.129974005212;4644.512326205768;4652.74409907455;4653.930191047137;4656.604188643969;4657.86026419208;4872.829450969234;5018.071656743514;5019.121653710586;5033.219850923077;5042.3949126104735;5023.372078490189;5026.095302845486;5029.220470827027;5031.22016087507;5107.182850743863;4716.646251531149;4756.524347565216;4766.785494652749;4776.379070720784;4816.903661926777;5131.102057139986;5174.146265866165;5176.068307704574;5195.271584617702;5286.62993590445;4957.628177886673;4962.950370496321;4973.2042873140845;4976.776045077908;5013.5989120870245;5016.322796422509;5029.547340739351;5070.619703522177;5079.212722028092;5086.262491938648;4954.058728841508;4981.053599816023;5000.1249781288125;5010.248462730547;5022.899542009212;4948.208286674187;4954.157793175169;4957.182064959314;4982.6512144149565;5040.873978150502;4114.423980642712;4211.957880421157;4231.788410579458;4239.8092085856215;4280.165367753259;3621.9275614487565;3715.8327875245677;3745.045013521589;3763.5671897731563;3787.5076240089165;4392.3191905254735;4406.184855801687;4422.115576884636;4456.799444025027;4498.347739577808;4886.804527818847;4957.429895561984;5089.4147173074825;5096.1336572781975;5101.948980510221;4372.868813935587;4387.188370151533;4395.033092719596;4419.315006174048;4483.3723278741;4533.863984080417;4538.523455037173;4544.159330523864;4549.567791059844;4594.65540084495;4714.245720684674;4782.569568738831;4788.233882578771;4790.592799611933;4805.447373552016;5063.7468126592785;5098.515641014098;5112.028714544224;5120.052790233819;5126;4833.879153021203;4840.201366774443;4846.321514987975;4867.464578896248;4886.071646387175;4924.285978533164;4935.8025678972435;5045.646804723634;5053.772580233972;5059.747012649426;5024.497550244946;5046.697198167974;5074.416442109205;5086.21163719624;5129.128048231735;4943.134951383566;4945.109880221451;4946.653734238569;4948.183549714401;4963.652544322007;4750.406199225097;4875.1712208923855;4902.117618828645;4934.087193869145;4997.5002499749735;4834.63740219492;4847.781849816837;4862.00328932575;4888.217885138503;4903.460619331942;4951;4962.379702537183;4971.403431588233;4976.253561965589;4978.352814134139;4710.858674239641;4773.641976851681;4807.230843065093;4845.224764037737;4913.164761990542 04:55:18 INFO - PROCESS | 20514 | |1;ext.html;541.0428698626471;581.1515187825775;585.0580565289882;603.9577229593929;622.5579838314796;35613.64386356139;36741.81629091858;39858;39925.800370998106;40407;40679.38980915289;41035;41081.17837643245;41234.175316493725;41310.79344603273;7661.042369703801;7755.8061048473955;7796.532208067534;7815.335696465807;7838.255365740246;7666.38668906489;7728.806779830493;7790.649420776051;7791.4156438267355;7812.218778122199;7771.922280777205;7791.571463569501;7835.177306382833;7844.058712954425;7861.68553257869;7725.111612164589;7775.339096176832;7782.260685234894;7784.026996625422;7808.726694565691;7670.578118203496;7701.922980770177;7704.8844267336035;7739.9613001935195;7762.340201082915;29288;37212;37664;37901;37978.430323545166;2993.057186986114;3081.6302043754895;3151.8896838610767;3212.4538828399227;3317.4857897026;29283.85358073217;29820;30151;30398.69601304003;30951.535726964114;3478.5371083667565;3510.6489351064943;3541.1762942084847;3575.535180426528;3637.418013117888;242804;243669;243927;244220;245106;54555.454445455835;54963.45036549663;55198;55241.1713824293;55248.447515525135;33510.8324458381;34249.14377140542;34413.827930860185;35200.471992920124;35264.82367588145;12988.870111298955;12995.220286782824;13086.411111500005;13128.277944713132;13150.21098734079;10171.694849154537;10176.440295783803;10216.591336346612;10230.59077636901;10285.794284114276;18162.182701778453;18171.72742408865;18258.63482730338;18280.085995700163;18302.81697183011;6853.725850966005;6971.860562788817;7180.8922866157045;7184.676689548983;7191.280871912767;824.8061705499202;853.6286715278874;952.2572393533055;971.5967873332629;985.4826216236534;27150.5927411089;27201.183964481097;27598.44803103927;27991.72008279891;28006.439871202463;987.2990176974286;994.7264502261792;1035.5909415780875;1080.3733834376044;1122.7473818390797;14360.784588231185;14627.853721462649;14820;14857;14890.106593604201;395614;406660;408031;408320;409996;48355.27467087997;49365;49767;49890;50000.49999500031;1206.203905422417;1210.152892974921;1217.1479964025218;1220.8412906322299;1221.5480272299128;26681.7331826687;27353.45293094087;27631.585526217525;27859.303517412227;28017;41159.38260926028;41780.791096044326;41994.790026049675;42069.15861682811;42240.15519689528;360260;361994;364419;364690;364723;24437.38906527351;25594.360140996625;25643.230703078938;25705.10032148866;25758.227253182435;41543.169136617704;42214.366784498874;42832.57167428286;42867.57132428761;43529.34705979476;36592.26815463623;36938.44592331171;37144.25711485809;37246.81376593208;37559.061023473536;35863.64136358603;35968.8201559001;36401.635983639826;36870.63129368672;36913.261734764616;35521.467177991835;36098.45852312165;37105;37260.44109338308;39021.2195756089;30574.694253058075;33511.16222094467;33659.15852103717;33816.1545961353;33889;25587.744122558535;26034.86982565151;26314.86842565775;26321.07876224323;26524.734752652228 04:55:18 INFO - PROCESS | 20514 | |2;jquery.html;371.6487918916623;372.5454944967139;376.06360163193636;384.7383779030258;390.1416882857712;15942.123183224918;16138.19309034548;16465.34138634453;16547.58631034225;16568.58578535537;15616.453424130157;15766.605834854134;16528.09095499747;16536.090515021668;16553.503394898173;5032.220005899073;5193.662411943231;5196.3764348278255;5232.843014709565;5249.553787928031;3717.55389353278;5114.514121158502;5644.096944488882;5940.554458415614;5945.316288626798;5960.403959604048;5995.85010374742;6001.429864162919;6017.06735456005;6018;5859.326177489601;6037.094435834616;6155.353687862755;6158.753649854;6171.074338849164;5155.432902380772;5303.787848486056;5312.787488500456;5323.733813309319;5347.732613369316;19270;19718.21127154912;19795.802041979685;19808.504787380287;19859.205631774712;1952.160570954489;1962.8233458988616;1979.356709069558;2089.98955005224;2135.124598914453;12760.872391276062;12824.358782060954;12866.099373043891;12988.545400911018;13172;1746.5458980665119;1786.6516029374277;1810.9456716298532;1856.793084495089;1889.1593241007756;66687;68060.6596967017;68165.97751033788;68182.65908670475;70001;9273.907260927304;9509.524523773784;9528.618855245852;9644.373115747454;9717.271204659679;12889;12915.160514566523;12918.483260669467;12925.741485170432;12997.740045199043;6675.4325882300545;6954.756583519553;6993.755218567428;7076.823079423056;7091.574505529685;6547.508936829757;6584.407403333723;6703.698333574904;6785.1518560179975;6796.25241223465;3831.8467261309233;3869.4582758413844;4121.361189015707;4180.602842729936;4223.535411104776;1639.6802623488543;1830.6544689653094;2979.4190132923873;3048.527478240876;3250.837458127084;855.9015713193063;898.5686870302292;911.0661571888735;926.6988228825659;968.4867020479157;15596.84403155954;16242.350305987628;16264;16402.09788461646;16667.49997500077;857.9742607721778;890.6062012949712;910.01263628962;910.8132832769398;917.3486824354783;8941.821163576693;9188.816223675489;9190.11602621461;9340;9427.57575909072;401647;411836;420257;425785;426865;76365.23634763582;76927;77993;78717.21282787214;79027.99999999885;914.3919293669635;919.7746552094779;946.3281070440065;954.4750387286964;959.9520023998772;13614.31928403556;14361.210133442342;14489.78265326;14782;15012.6997460048;35626.46560301649;36433.63566364302;36939.26121477609;37231.81384093062;37616.24767504689;48310.516894832006;48942.51057489379;49516;50966.490335096176;51722.74138629283;7288;7288.380487658608;7292.307230813064;7318.524295920748;7444.702211911679;7993.92006079955;10184.490775461345;11145.609903653332;11204.159688023268;11401.3729244889;9719.708408747749;9863.457509837028;9937.304388692723;10241.539130738985;10305.433201173708;9564.330496865152;9865.950670246602;9984.900150998397;10092.84860727075;10340.586376544854;8822.25010874083;8925.928888533417;10199.13307368882;10410.635627752992;10536.52585633633;7464.954906313012;7532.924670753222;7601.315881570686;7614.894498136291;7711.614419278902;7561.886571701539;9604.615815367308;10078.445685487368;10371.740706482096;10453.9477302613 04:55:18 INFO - PROCESS | 20514 | |3;mootools.html;1385.722855428914;1403.7192561487702;1478.778183272509;1717.7766890304258;1743.6338368942522;6563.868722625544;7177.497575169734;7374;7585.696572137122;7601.961990190048;7499.837525183591;7644.923550764491;7699.807504812383;7706.922930770691;7738.419618528605;2175.1734340950416;2209.7790220977936;2211.7456492503406;2211.8562293450955;2218.090582861027;2176.542925985545;2210.557888422314;2212.048819007826;2222.9110835566557;2231.1856172497005;2203.9889800550973;2206.249875042485;2212.0930418528405;2212.2478357358495;2228.810551103158;2156.482444213393;2156.5255643758346;2160;2162.275637661385;2165.880876551781;2148.9462763430884;2157.557700671359;2164.4372463159693;2165.4586353411646;2171.185805323004;7676.692932282702;7711.305982461606;7715.151333353327;7715.922840771576;7720.343770779435;4316.784160791948;4413.668974826901;4434.600885920283;4474.753888536129;4486.55134486552;2758.241483592008;2869.210966984096;2887.6967918368478;2912.053582585668;2935.5890175375466;880.6697488441835;937.4515908193647;948.0472125513884;949.3449519831295;950.6672664567416;10451.320664156805;10468;10517.368957862553;10525;10563.894361056367;4100.712950093465;4190.622843944059;4228.6617070634275;4237.152569486115;4269.573042695705;8964.327675424369;8965.193132618097;9012;9055;9071.682491112779;4391.912161756747;4432.357308190294;4446.777661116931;4448.288273876165;4454.086912182995;3425.9314813703586;3790.50723405961;3917.882463526099;3942.9211415772097;3960.346542820402;3638.599754027055;3681.9263614727556;3738.925221495609;3756.849726010929;3885.747426417274;1180.7815554122344;1188.441432526711;1191.1780871198846;1192.5051103792002;1192.8270400791837;862.0861886400436;867.2628265973872;887.0552861202798;887.9955600222087;896.4934811831295;5125.231215317732;5196.610254230948;5540.196671482612;5636.802711905064;5756.194132821408;835.6114406800867;883.1830556734994;919.6643225222879;935.3265648732902;937.7280588629358;3874.12832112778;3930;3963.246983073207;3963.900902477461;3967.0677390813134;9125;9435.52822358893;9468.100530449596;9474.668386606574;9519.524023798782;9281.396709214014;9322.440653560809;9352.205062569758;9356.578953946953;9357.485338306322;7107.147142342848;7174.856502869913;7258.891116633255;7265.164506081763;7282.271772822675;5263.842084737464;5363.973180134074;5491.203775452617;5541.584381171348;5557.083081291542;8528.91471085306;8532.146785321418;8633.093525179765;8801.427907186013;8812.16284452976;8820.426672266281;8862.734117976472;8897.911020889967;8899.555022248733;8923.866142008004;5646.322441306905;5806.65160090396;5995.400459954144;6390.87218255623;6546.312637173029;7409.407247420301;7420.851582968418;7445.627718614156;7569.583672898044;7574.848503030019;6637.601743895381;6845.623490708059;6877.65611719422;6884.552504087218;6917.13535808024;6478.093066970534;6501.9674901625185;6530.053142294436;6573.5069869759;6584.209894812653;6198.876022479435;6239.625622462667;6274.215723034621;6277.403646653744;6277.5605707600025;4452.666050046195;4693.577578017995;4705.670603057753;4737.786799593958;4766.761661916821;4673.639811894971;4719;4758.833440829693;4811.591014763644;4821.686590371614 04:55:18 INFO - PROCESS | 20514 | |4;prototype.html;284.7351962674713;290.7514075465477;294.70823884354485;298.0091196770738;299.1369897844719;4831.4685384607665;4881.560659540641;4989.875253118674;5008.874778130548;5045.889904221065;4907.312976183337;4928.1868491698915;4940.209566469365;4942.135126352892;4950.405951285851;3864.188520410717;3893.552241492222;3902.1025164212247;3912.8434862605463;3927.2341893330813;3606.1525541497726;3931.272714547818;3943.5859234780364;3945.072907866649;3956.643902048815;3739.364308067635;3788.981055094721;3791.867284645038;3794.4118661607495;3810.6760925321382;3788.621137886203;3809.8666546670734;3810.3903375460072;3817.351050321438;3821.3503704370046;3173.9206519836957;3262.673732626742;3282.9343413131605;3338.1821453743746;3346.9624416430984;4645.279981602857;4652.74409907455;4674.322223277606;4681.180793361183;4681.648876334254;4305;4313.698041137121;4313.741175529447;4328.7402755834755;4330;5103.5151660592555;5207.661502002357;5208.739563021833;5222.8694282642855;5231.718229033873;3577.8032208228537;3593.1196856770257;3601.333753255656;3611.0611241077245;3620.7103431725664;5410.729463526808;5443.646162999432;5457.945420545783;5487.972560137174;5500.28496295483;3685.8894233173046;3694.4827724118645;3697.5932647408763;3704.111013356775;3706;3622.836972336251;3776.546814382237;3779.5464544254864;3787.5644300905196;3795.69634429245;4298.376735373354;4325.84859529915;4332.545082766327;4335.436393268855;4339.869803905888;5153.948460515422;5202.375714914235;5204.115300398941;5225.137852254412;5250.7374631268285;1228.6928267933017;1269.5112381732915;1299.2334522631693;1303.882650561435;1307.6730817295677;801.9894932385237;815.3517953227199;829.1294141151767;840.3906519016138;840.5923127283263;4143.274926887782;4156.521999969982;4162.958370416318;4178;4211.263028969979;4740.573348398591;4755.643326750507;4765.26138448541;4779.689320194177;4786.736729479842;4155.633936511435;4212.7472351659;4245.344315716873;4250.129942825147;4275.828966841292;2581.889787391402;2656.2164161571995;2873.6264285642733;2907.476654202264;2910.777473461151;5099.617528685363;5102.36220472441;5108.131617624938;5157.303763991888;5169.767360468788;5278.208268759717;5506;5514.696691681996;5551.7779288828;5562.495627754489;5066.620003499752;5080.288759573663;5090.694558326438;5097.286379906742;5133.3326667534475;5390.110631745718;5435.2934118564335;5436.157395603688;5440.755166017618;5454.618176727591;5083.212102124176;5253.973730131325;5281.705982034427;5297.947020529899;5306.946930530646;5078.882645817914;5103.157978933435;5108.872278193075;5147.150720131136;5155.072087024221;3646.5441819772527;3676.9080772980888;3694.7413681042067;3694.8891533254045;3705.6850167736043;5213.270142180022;5358.598105142208;5400.486953739545;5401.8919621606565;5404.7297635118875;5177.534021938043;5182.24857395683;5186.974065129651;5202.843914682566;5209.47905209476;5143.92284115731;5180.9740951295;5188.9740551297;5189.584833213409;5233.947660523499;4901.655470368141;5077.669951453144;5088.4148322941855;5124.974375128249;5142.331496905378;5174.689518628894;5226.163813789927;5233.947660523499;5242.947570524246;5249.08141075318;5100.974495127501;5120.283160357479;5127.564157046693;5145.867909060001;5171.120909445479 04:55:18 INFO - PROCESS | 20514 | |5;yui.html;660.3000819131721;660.9834754131149;689.5793565924785;700.4641449291294;737.7233537423466;11927.58253461129;12833.743325133491;12880.806787898166;12918.354082295895;12944.676383090416;11987.760244795121;12002.759944801099;12021.09841761867;12042.57850975216;12044.457999390026;613.9201903752506;765.3035737478896;775.3409601838449;775.6470805783355;784.1256998446719;785.2579312549643;786.0842118931438;786.3119770201074;789.3251270164013;794.5709316968859;831.7962099285684;835.2900034970257;836.2014276366086;839.2237180607943;841.2596914715042;829.1749709039514;829.9045609754895;830.667732906836;832.196929962589;833.0503226322028;604.2205554834259;608.0362625239002;608.9025755879082;611.966341851198;612.5865041097242;12421.75156496865;12444.253344799341;12488.875111248863;12490.625281241577;12538.059645526622;12717.30054846983;13263.403146858414;13362.131461454974;13399.531016414476;13417.194968301836;10258.281920265585;10308.536115874804;10496.895031049668;10539.209559283008;10573.259871808976;3359.882404115844;3394.0835974286806;3433.6738009889023;3445.1214940190343;3531.6644918732677;57955.710221449044;58817.7059114706;59260;60689.08966365508;61414;10518.579256829795;10530.104941080093;10597.84103238452;10730.731731706614;10934.179936504794;19864.10611522485;19928.70106948397;19961;19993.600127997357;19994.90002549978;6627.271000189975;6882.208546017172;6980.057692211588;7017.789466316019;7022.0520229769345;3743.42672093649;3832.4251362295877;3872.457855900176;3885.592012838668;3949.5260568731937;2877.9712202878122;2995.026616349695;2995.670476247611;3000.219942814884;3010.864511097006;511.3148381169251;525.256761682223;542.1271752478507;546.9507744303032;548.8408361575179;550.0429253099658;564.5032371513042;585.157373382328;592.863641362489;608.1273372710086;7643.197464266172;7965.721199757981;8165.774519064936;8278.503289802631;8586.65653373858;575.2780260772787;576.2681394628798;578.3724658745224;578.8032069096528;579.6782785554058;3706.3884459064493;3776.7167462440425;3916.6670832979516;3968.583298753647;3985.362342025262;79730.60134699405;88109;89780.5510972454;91717;92867.53566232126;53096;78034.6098269505;78397.60801196072;81573.9999999988;84023;68331.3166868335;69392.6530367345;69654.65172674104;69838.3016169842;70235.6488217566;7129.500934934505;7182.425405967615;7343.375813055736;7386.482946193715;7514.774556763306;34849.82575087108;43569.78215108904;44009;44548.109037818416;44884;60199.39800601938;60206;60483.39516604954;60630.696846515486;60655;9217.585208665492;9253.537323133682;9254;9297.535123243946;9430.481323527272;10688.893111069101;10693.09108725767;10693.251472397169;10694.41180735067;10705.304155229886;9735.1725103367;9955.601775929172;10047.949760251153;10155.492225388552;10297.330673506198;9647.372920760128;9831.213502919893;10039.146672532917;10268.691939241835;10287.94856025745;9641.27690423207;9691.2731545133;9886.950565247127;9922.40465572068;10237.027482389161;8192.18078192176;8254.42219044661;8347.415680902279;8353.24820766134;8526.658933642833;7887.723929662434;8520.105388934073;8528.317734581095;8817.470951742916;8827.24968377695 04:55:18 INFO - PROCESS | 20514 | __end_tp_report 04:55:18 INFO - PROCESS | 20514 | __start_cc_report 04:55:18 INFO - PROCESS | 20514 | _x_x_mozilla_cycle_collect,398 04:55:18 INFO - PROCESS | 20514 | __end_cc_report 04:55:18 INFO - PROCESS | 20514 | __startTimestamp1465300518062__endTimestamp 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | ------- Summary: start ------- 04:55:18 INFO - PROCESS | 20514 | Number of tests: 6 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#0] dojo.html Cycles:165 Average:4645.44 Median:4816.90 stddev:588.30 (12.2%) stddev-sans-first:569.36 04:55:18 INFO - PROCESS | 20514 | Values: 2671.4 2674.5 2681.8 2710.5 2729.3 4725.6 4735.1 4753.1 4759.8 4822.5 4584.2 4673.8 4678.5 4733.4 4762.7 4267.5 4276.6 4358.2 4367.9 4377.3 356.6 4277.5 4304.5 4311.2 4319.2 4296.1 4299.4 4335.9 4338.2 4372.2 4330.0 4331.4 4334.0 4337.5 4352.3 4281.6 4323.7 4347.1 4348.0 4350.1 4644.5 4652.7 4653.9 4656.6 4657.9 4872.8 5018.1 5019.1 5033.2 5042.4 5023.4 5026.1 5029.2 5031.2 5107.2 4716.6 4756.5 4766.8 4776.4 4816.9 5131.1 5174.1 5176.1 5195.3 5286.6 4957.6 4963.0 4973.2 4976.8 5013.6 5016.3 5029.5 5070.6 5079.2 5086.3 4954.1 4981.1 5000.1 5010.2 5022.9 4948.2 4954.2 4957.2 4982.7 5040.9 4114.4 4212.0 4231.8 4239.8 4280.2 3621.9 3715.8 3745.0 3763.6 3787.5 4392.3 4406.2 4422.1 4456.8 4498.3 4886.8 4957.4 5089.4 5096.1 5101.9 4372.9 4387.2 4395.0 4419.3 4483.4 4533.9 4538.5 4544.2 4549.6 4594.7 4714.2 4782.6 4788.2 4790.6 4805.4 5063.7 5098.5 5112.0 5120.1 5126.0 4833.9 4840.2 4846.3 4867.5 4886.1 4924.3 4935.8 5045.6 5053.8 5059.7 5024.5 5046.7 5074.4 5086.2 5129.1 4943.1 4945.1 4946.7 4948.2 4963.7 4750.4 4875.2 4902.1 4934.1 4997.5 4834.6 4847.8 4862.0 4888.2 4903.5 4951.0 4962.4 4971.4 4976.3 4978.4 4710.9 4773.6 4807.2 4845.2 4913.2 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#1] ext.html Cycles:180 Average:48471.50 Median:36667.04 stddev:90982.12 (248.1%) stddev-sans-first:91166.18 04:55:18 INFO - PROCESS | 20514 | Values: 541.0 581.2 585.1 604.0 622.6 35613.6 36741.8 39858.0 39925.8 40407.0 40679.4 41035.0 41081.2 41234.2 41310.8 7661.0 7755.8 7796.5 7815.3 7838.3 7666.4 7728.8 7790.6 7791.4 7812.2 7771.9 7791.6 7835.2 7844.1 7861.7 7725.1 7775.3 7782.3 7784.0 7808.7 7670.6 7701.9 7704.9 7740.0 7762.3 29288.0 37212.0 37664.0 37901.0 37978.4 2993.1 3081.6 3151.9 3212.5 3317.5 29283.9 29820.0 30151.0 30398.7 30951.5 3478.5 3510.6 3541.2 3575.5 3637.4 242804.0 243669.0 243927.0 244220.0 245106.0 54555.5 54963.5 55198.0 55241.2 55248.4 33510.8 34249.1 34413.8 35200.5 35264.8 12988.9 12995.2 13086.4 13128.3 13150.2 10171.7 10176.4 10216.6 10230.6 10285.8 18162.2 18171.7 18258.6 18280.1 18302.8 6853.7 6971.9 7180.9 7184.7 7191.3 824.8 853.6 952.3 971.6 985.5 27150.6 27201.2 27598.4 27991.7 28006.4 987.3 994.7 1035.6 1080.4 1122.7 14360.8 14627.9 14820.0 14857.0 14890.1 395614.0 406660.0 408031.0 408320.0 409996.0 48355.3 49365.0 49767.0 49890.0 50000.5 1206.2 1210.2 1217.1 1220.8 1221.5 26681.7 27353.5 27631.6 27859.3 28017.0 41159.4 41780.8 41994.8 42069.2 42240.2 360260.0 361994.0 364419.0 364690.0 364723.0 24437.4 25594.4 25643.2 25705.1 25758.2 41543.2 42214.4 42832.6 42867.6 43529.3 36592.3 36938.4 37144.3 37246.8 37559.1 35863.6 35968.8 36401.6 36870.6 36913.3 35521.5 36098.5 37105.0 37260.4 39021.2 30574.7 33511.2 33659.2 33816.2 33889.0 25587.7 26034.9 26314.9 26321.1 26524.7 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#2] jquery.html Cycles:180 Average:24921.53 Median:5134.97 stddev:68747.28 (1338.8%) stddev-sans-first:68915.42 04:55:18 INFO - PROCESS | 20514 | Values: 371.6 372.5 376.1 384.7 390.1 15942.1 16138.2 16465.3 16547.6 16568.6 15616.5 15766.6 16528.1 16536.1 16553.5 5032.2 5193.7 5196.4 5232.8 5249.6 3717.6 5114.5 5644.1 5940.6 5945.3 5960.4 5995.9 6001.4 6017.1 6018.0 5859.3 6037.1 6155.4 6158.8 6171.1 5155.4 5303.8 5312.8 5323.7 5347.7 19270.0 19718.2 19795.8 19808.5 19859.2 1952.2 1962.8 1979.4 2090.0 2135.1 12760.9 12824.4 12866.1 12988.5 13172.0 1746.5 1786.7 1810.9 1856.8 1889.2 66687.0 68060.7 68166.0 68182.7 70001.0 9273.9 9509.5 9528.6 9644.4 9717.3 12889.0 12915.2 12918.5 12925.7 12997.7 6675.4 6954.8 6993.8 7076.8 7091.6 6547.5 6584.4 6703.7 6785.2 6796.3 3831.8 3869.5 4121.4 4180.6 4223.5 1639.7 1830.7 2979.4 3048.5 3250.8 855.9 898.6 911.1 926.7 968.5 15596.8 16242.4 16264.0 16402.1 16667.5 858.0 890.6 910.0 910.8 917.3 8941.8 9188.8 9190.1 9340.0 9427.6 401647.0 411836.0 420257.0 425785.0 426865.0 76365.2 76927.0 77993.0 78717.2 79028.0 914.4 919.8 946.3 954.5 960.0 13614.3 14361.2 14489.8 14782.0 15012.7 35626.5 36433.6 36939.3 37231.8 37616.2 48310.5 48942.5 49516.0 50966.5 51722.7 7288.0 7288.4 7292.3 7318.5 7444.7 7993.9 10184.5 11145.6 11204.2 11401.4 9719.7 9863.5 9937.3 10241.5 10305.4 9564.3 9866.0 9984.9 10092.8 10340.6 8822.3 8925.9 10199.1 10410.6 10536.5 7465.0 7532.9 7601.3 7614.9 7711.6 7561.9 9604.6 10078.4 10371.7 10453.9 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#3] mootools.html Cycles:180 Average:5082.62 Median:5540.89 stddev:2792.22 (50.4%) stddev-sans-first:2786.23 04:55:18 INFO - PROCESS | 20514 | Values: 1385.7 1403.7 1478.8 1717.8 1743.6 6563.9 7177.5 7374.0 7585.7 7602.0 7499.8 7644.9 7699.8 7706.9 7738.4 2175.2 2209.8 2211.7 2211.9 2218.1 2176.5 2210.6 2212.0 2222.9 2231.2 2204.0 2206.2 2212.1 2212.2 2228.8 2156.5 2156.5 2160.0 2162.3 2165.9 2148.9 2157.6 2164.4 2165.5 2171.2 7676.7 7711.3 7715.2 7715.9 7720.3 4316.8 4413.7 4434.6 4474.8 4486.6 2758.2 2869.2 2887.7 2912.1 2935.6 880.7 937.5 948.0 949.3 950.7 10451.3 10468.0 10517.4 10525.0 10563.9 4100.7 4190.6 4228.7 4237.2 4269.6 8964.3 8965.2 9012.0 9055.0 9071.7 4391.9 4432.4 4446.8 4448.3 4454.1 3425.9 3790.5 3917.9 3942.9 3960.3 3638.6 3681.9 3738.9 3756.8 3885.7 1180.8 1188.4 1191.2 1192.5 1192.8 862.1 867.3 887.1 888.0 896.5 5125.2 5196.6 5540.2 5636.8 5756.2 835.6 883.2 919.7 935.3 937.7 3874.1 3930.0 3963.2 3963.9 3967.1 9125.0 9435.5 9468.1 9474.7 9519.5 9281.4 9322.4 9352.2 9356.6 9357.5 7107.1 7174.9 7258.9 7265.2 7282.3 5263.8 5364.0 5491.2 5541.6 5557.1 8528.9 8532.1 8633.1 8801.4 8812.2 8820.4 8862.7 8897.9 8899.6 8923.9 5646.3 5806.7 5995.4 6390.9 6546.3 7409.4 7420.9 7445.6 7569.6 7574.8 6637.6 6845.6 6877.7 6884.6 6917.1 6478.1 6502.0 6530.1 6573.5 6584.2 6198.9 6239.6 6274.2 6277.4 6277.6 4452.7 4693.6 4705.7 4737.8 4766.8 4673.6 4719.0 4758.8 4811.6 4821.7 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#4] prototype.html Cycles:180 Average:4262.66 Median:4856.51 stddev:1267.91 (26.1%) stddev-sans-first:1235.81 04:55:18 INFO - PROCESS | 20514 | Values: 284.7 290.8 294.7 298.0 299.1 4831.5 4881.6 4989.9 5008.9 5045.9 4907.3 4928.2 4940.2 4942.1 4950.4 3864.2 3893.6 3902.1 3912.8 3927.2 3606.2 3931.3 3943.6 3945.1 3956.6 3739.4 3789.0 3791.9 3794.4 3810.7 3788.6 3809.9 3810.4 3817.4 3821.4 3173.9 3262.7 3282.9 3338.2 3347.0 4645.3 4652.7 4674.3 4681.2 4681.6 4305.0 4313.7 4313.7 4328.7 4330.0 5103.5 5207.7 5208.7 5222.9 5231.7 3577.8 3593.1 3601.3 3611.1 3620.7 5410.7 5443.6 5457.9 5488.0 5500.3 3685.9 3694.5 3697.6 3704.1 3706.0 3622.8 3776.5 3779.5 3787.6 3795.7 4298.4 4325.8 4332.5 4335.4 4339.9 5153.9 5202.4 5204.1 5225.1 5250.7 1228.7 1269.5 1299.2 1303.9 1307.7 802.0 815.4 829.1 840.4 840.6 4143.3 4156.5 4163.0 4178.0 4211.3 4740.6 4755.6 4765.3 4779.7 4786.7 4155.6 4212.7 4245.3 4250.1 4275.8 2581.9 2656.2 2873.6 2907.5 2910.8 5099.6 5102.4 5108.1 5157.3 5169.8 5278.2 5506.0 5514.7 5551.8 5562.5 5066.6 5080.3 5090.7 5097.3 5133.3 5390.1 5435.3 5436.2 5440.8 5454.6 5083.2 5254.0 5281.7 5297.9 5306.9 5078.9 5103.2 5108.9 5147.2 5155.1 3646.5 3676.9 3694.7 3694.9 3705.7 5213.3 5358.6 5400.5 5401.9 5404.7 5177.5 5182.2 5187.0 5202.8 5209.5 5143.9 5181.0 5189.0 5189.6 5233.9 4901.7 5077.7 5088.4 5125.0 5142.3 5174.7 5226.2 5233.9 5242.9 5249.1 5101.0 5120.3 5127.6 5145.9 5171.1 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - PROCESS | 20514 | [#5] yui.html Cycles:180 Average:16563.99 Median:60202.70 stddev:23451.89 (39.0%) stddev-sans-first:23487.27 04:55:18 INFO - PROCESS | 20514 | Values: 660.3 661.0 689.6 700.5 737.7 11927.6 12833.7 12880.8 12918.4 12944.7 11987.8 12002.8 12021.1 12042.6 12044.5 613.9 765.3 775.3 775.6 784.1 785.3 786.1 786.3 789.3 794.6 831.8 835.3 836.2 839.2 841.3 829.2 829.9 830.7 832.2 833.1 604.2 608.0 608.9 612.0 612.6 12421.8 12444.3 12488.9 12490.6 12538.1 12717.3 13263.4 13362.1 13399.5 13417.2 10258.3 10308.5 10496.9 10539.2 10573.3 3359.9 3394.1 3433.7 3445.1 3531.7 57955.7 58817.7 59260.0 60689.1 61414.0 10518.6 10530.1 10597.8 10730.7 10934.2 19864.1 19928.7 19961.0 19993.6 19994.9 6627.3 6882.2 6980.1 7017.8 7022.1 3743.4 3832.4 3872.5 3885.6 3949.5 2878.0 2995.0 2995.7 3000.2 3010.9 511.3 525.3 542.1 547.0 548.8 550.0 564.5 585.2 592.9 608.1 7643.2 7965.7 8165.8 8278.5 8586.7 575.3 576.3 578.4 578.8 579.7 3706.4 3776.7 3916.7 3968.6 3985.4 79730.6 88109.0 89780.6 91717.0 92867.5 53096.0 78034.6 78397.6 81574.0 84023.0 68331.3 69392.7 69654.7 69838.3 70235.6 7129.5 7182.4 7343.4 7386.5 7514.8 34849.8 43569.8 44009.0 44548.1 44884.0 60199.4 60206.0 60483.4 60630.7 60655.0 9217.6 9253.5 9254.0 9297.5 9430.5 10688.9 10693.1 10693.3 10694.4 10705.3 9735.2 9955.6 10047.9 10155.5 10297.3 9647.4 9831.2 10039.1 10268.7 10287.9 9641.3 9691.3 9887.0 9922.4 10237.0 8192.2 8254.4 8347.4 8353.2 8526.7 7887.7 8520.1 8528.3 8817.5 8827.2 04:55:18 INFO - PROCESS | 20514 | -------- Summary: end -------- 04:55:18 INFO - PROCESS | 20514 | 04:55:18 INFO - TEST-INFO | 20514: exit 0 04:55:18 INFO - TEST-OK | dromaeo_css | took 1115689ms 04:55:18 INFO - TEST-START | kraken 04:55:18 INFO - operating with platform_type : linux_ 04:55:18 INFO - Initialising browser for kraken test... 04:55:18 INFO - TEST-INFO | started process 20747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzakS2q/profile http://localhost:38654/getInfo.html) 04:55:24 INFO - PROCESS | 20747 | __metrics Screen width/height:1600/1200 04:55:24 INFO - PROCESS | 20747 | colorDepth:24 04:55:24 INFO - PROCESS | 20747 | Browser inner width/height: 1024/697 04:55:24 INFO - PROCESS | 20747 | __metrics 04:55:24 ERROR - PROCESS | 20747 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:55:25 INFO - TEST-INFO | 20747: exit 0 04:55:25 INFO - Browser initialized. 04:55:25 INFO - Running cycle 1/1 for kraken test... 04:55:25 INFO - TEST-INFO | started process 20865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzakS2q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:37 INFO - PROCESS | 20865 | RSS: Main: 168140800 04:55:37 INFO - PROCESS | 20865 | 04:55:40 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38654/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:41 INFO - PROCESS | 20865 | RSS: Main: 173109248 04:55:41 INFO - PROCESS | 20865 | 04:55:44 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38654/tests/kraken/driver.html?testName=audio-dft) 04:55:44 INFO - PROCESS | 20865 | RSS: Main: 173867008 04:55:44 INFO - PROCESS | 20865 | 04:55:47 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38654/tests/kraken/driver.html?testName=audio-fft) 04:55:48 INFO - PROCESS | 20865 | RSS: Main: 167530496 04:55:48 INFO - PROCESS | 20865 | 04:55:50 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38654/tests/kraken/driver.html?testName=audio-oscillator) 04:55:51 INFO - PROCESS | 20865 | RSS: Main: 168243200 04:55:51 INFO - PROCESS | 20865 | 04:55:53 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:54 INFO - PROCESS | 20865 | RSS: Main: 168357888 04:55:54 INFO - PROCESS | 20865 | 04:55:57 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38654/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:57 INFO - PROCESS | 20865 | RSS: Main: 168869888 04:55:57 INFO - PROCESS | 20865 | 04:56:01 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38654/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:02 INFO - PROCESS | 20865 | RSS: Main: 166699008 04:56:02 INFO - PROCESS | 20865 | 04:56:05 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38654/tests/kraken/driver.html?testName=json-parse-financial) 04:56:05 INFO - PROCESS | 20865 | RSS: Main: 168275968 04:56:05 INFO - PROCESS | 20865 | 04:56:07 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:08 INFO - PROCESS | 20865 | RSS: Main: 168476672 04:56:08 INFO - PROCESS | 20865 | 04:56:09 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:10 INFO - PROCESS | 20865 | RSS: Main: 168259584 04:56:10 INFO - PROCESS | 20865 | 04:56:12 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:13 INFO - PROCESS | 20865 | RSS: Main: 168706048 04:56:13 INFO - PROCESS | 20865 | 04:56:16 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:16 INFO - PROCESS | 20865 | RSS: Main: 169156608 04:56:16 INFO - PROCESS | 20865 | 04:56:19 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:20 INFO - PROCESS | 20865 | RSS: Main: 168579072 04:56:20 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | Cycle 1(1): loaded http://localhost:38654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38654/tests/kraken/driver.html?testName=ai-astar) 04:56:22 INFO - PROCESS | 20865 | RSS: Main: 169607168 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | __start_tp_report 04:56:22 INFO - PROCESS | 20865 | _x_x_mozilla_page_load 04:56:22 INFO - PROCESS | 20865 | _x_x_mozilla_page_load_details 04:56:22 INFO - PROCESS | 20865 | |i|pagename|runs| 04:56:22 INFO - PROCESS | 20865 | |0;ai-astar;114;108;115;113;115;113;114;115;114;113 04:56:22 INFO - PROCESS | 20865 | |1;audio-beat-detection;153;133;157;191;134;161;157;132;195;138 04:56:22 INFO - PROCESS | 20865 | |2;audio-dft;162;164;166;176;162;162;161;163;163;163 04:56:22 INFO - PROCESS | 20865 | |3;audio-fft;87;77;77;179;77;76;77;76;166;76 04:56:22 INFO - PROCESS | 20865 | |4;audio-oscillator;87;87;146;86;86;86;142;86;85;133 04:56:22 INFO - PROCESS | 20865 | |5;imaging-gaussian-blur;118;117;117;118;118;117;119;118;117;118 04:56:22 INFO - PROCESS | 20865 | |6;imaging-darkroom;148;150;148;147;148;148;148;148;147;146 04:56:22 INFO - PROCESS | 20865 | |7;imaging-desaturate;96;95;95;96;96;95;95;96;96;96 04:56:22 INFO - PROCESS | 20865 | |8;json-parse-financial;64;64;64;67;65;67;65;63;66;64 04:56:22 INFO - PROCESS | 20865 | |9;json-stringify-tinderbox;66;68;67;66;65;66;65;66;66;66 04:56:22 INFO - PROCESS | 20865 | |10;stanford-crypto-aes;85;82;83;85;90;88;86;85;111;87 04:56:22 INFO - PROCESS | 20865 | |11;stanford-crypto-ccm;150;133;137;130;136;133;135;135;149;134 04:56:22 INFO - PROCESS | 20865 | |12;stanford-crypto-pbkdf2;171;169;167;169;175;173;175;168;166;178 04:56:22 INFO - PROCESS | 20865 | |13;stanford-crypto-sha256-iterative;70;69;69;67;76;69;67;66;70;67 04:56:22 INFO - PROCESS | 20865 | __end_tp_report 04:56:22 INFO - PROCESS | 20865 | __start_cc_report 04:56:22 INFO - PROCESS | 20865 | _x_x_mozilla_cycle_collect,992 04:56:22 INFO - PROCESS | 20865 | __end_cc_report 04:56:22 INFO - PROCESS | 20865 | __startTimestamp1465300582422__endTimestamp 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | ------- Summary: start ------- 04:56:22 INFO - PROCESS | 20865 | Number of tests: 14 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.07 (1.8%) stddev-sans-first:2.18 04:56:22 INFO - PROCESS | 20865 | Values: 114.0 108.0 115.0 113.0 115.0 113.0 114.0 115.0 114.0 113.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:157.00 stddev:22.82 (14.5%) stddev-sans-first:24.19 04:56:22 INFO - PROCESS | 20865 | Values: 153.0 133.0 157.0 191.0 134.0 161.0 157.0 132.0 195.0 138.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:4.37 (2.7%) stddev-sans-first:4.56 04:56:22 INFO - PROCESS | 20865 | Values: 162.0 164.0 166.0 176.0 162.0 162.0 161.0 163.0 163.0 163.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#3] audio-fft Cycles:10 Average:96.80 Median:77.00 stddev:40.15 (52.1%) stddev-sans-first:42.43 04:56:22 INFO - PROCESS | 20865 | Values: 87.0 77.0 77.0 179.0 77.0 76.0 77.0 76.0 166.0 76.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.00 stddev:26.37 (30.7%) stddev-sans-first:27.37 04:56:22 INFO - PROCESS | 20865 | Values: 87.0 87.0 146.0 86.0 86.0 86.0 142.0 86.0 85.0 133.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:56:22 INFO - PROCESS | 20865 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 119.0 118.0 117.0 118.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 04:56:22 INFO - PROCESS | 20865 | Values: 148.0 150.0 148.0 147.0 148.0 148.0 148.0 148.0 147.0 146.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:56:22 INFO - PROCESS | 20865 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.41 04:56:22 INFO - PROCESS | 20865 | Values: 64.0 64.0 64.0 67.0 65.0 67.0 65.0 63.0 66.0 64.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 04:56:22 INFO - PROCESS | 20865 | Values: 66.0 68.0 67.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:85.50 stddev:8.34 (9.8%) stddev-sans-first:8.76 04:56:22 INFO - PROCESS | 20865 | Values: 85.0 82.0 83.0 85.0 90.0 88.0 86.0 85.0 111.0 87.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:135.50 stddev:6.76 (5.0%) stddev-sans-first:5.36 04:56:22 INFO - PROCESS | 20865 | Values: 150.0 133.0 137.0 130.0 136.0 133.0 135.0 135.0 149.0 134.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:172.00 stddev:3.98 (2.3%) stddev-sans-first:4.23 04:56:22 INFO - PROCESS | 20865 | Values: 171.0 169.0 167.0 169.0 175.0 173.0 175.0 168.0 166.0 178.0 04:56:22 INFO - PROCESS | 20865 | 04:56:22 INFO - PROCESS | 20865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.83 (4.1%) stddev-sans-first:2.98 04:56:22 INFO - PROCESS | 20865 | Values: 70.0 69.0 69.0 67.0 76.0 69.0 67.0 66.0 70.0 67.0 04:56:22 INFO - PROCESS | 20865 | -------- Summary: end -------- 04:56:22 INFO - PROCESS | 20865 | 04:56:23 INFO - TEST-INFO | 20865: exit 0 04:56:23 INFO - TEST-OK | kraken | took 64988ms 04:56:23 INFO - SUITE-END | took 1180s 04:56:24 INFO - Completed test suite (00:19:40) 04:56:24 INFO - javascript benchmark 04:56:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6364.094188323722, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.4389978104596, 2674.491846549156, 2681.8390896546207, 2710.471458065678, 2729.2767416634583, 4725.551072648097, 4735.076660051292, 4753.1444340018825, 4759.785809638566, 4822.541858523444, 4584.243599806036, 4673.83641572545, 4678.461976872661, 4733.360996265503, 4762.666613337059, 4267.48790145183, 4276.615104640582, 4358.237308471021, 4367.890802729941, 4377.299632058871, 356.61208566651635, 4277.465316835395, 4304.461942257218, 4311.245532031898, 4319.200947824646, 4296.119295544406, 4299.376590394407, 4335.891602709926, 4338.240807858612, 4372.2130016597, 4330.025744207528, 4331.371951067078, 4334.0, 4337.479502459725, 4352.281873490871, 4281.571842815724, 4323.65410767141, 4347.130573885235, 4347.956520434786, 4350.129974005212, 4644.512326205768, 4652.74409907455, 4653.930191047137, 4656.604188643969, 4657.86026419208, 4872.829450969234, 5018.071656743514, 5019.121653710586, 5033.219850923077, 5042.3949126104735, 5023.372078490189, 5026.095302845486, 5029.220470827027, 5031.22016087507, 5107.182850743863, 4716.646251531149, 4756.524347565216, 4766.785494652749, 4776.379070720784, 4816.903661926777, 5131.102057139986, 5174.146265866165, 5176.068307704574, 5195.271584617702, 5286.62993590445, 4957.628177886673, 4962.950370496321, 4973.2042873140845, 4976.776045077908, 5013.5989120870245, 5016.322796422509, 5029.547340739351, 5070.619703522177, 5079.212722028092, 5086.262491938648, 4954.058728841508, 4981.053599816023, 5000.1249781288125, 5010.248462730547, 5022.899542009212, 4948.208286674187, 4954.157793175169, 4957.182064959314, 4982.6512144149565, 5040.873978150502, 4114.423980642712, 4211.957880421157, 4231.788410579458, 4239.8092085856215, 4280.165367753259, 3621.9275614487565, 3715.8327875245677, 3745.045013521589, 3763.5671897731563, 3787.5076240089165, 4392.3191905254735, 4406.184855801687, 4422.115576884636, 4456.799444025027, 4498.347739577808, 4886.804527818847, 4957.429895561984, 5089.4147173074825, 5096.1336572781975, 5101.948980510221, 4372.868813935587, 4387.188370151533, 4395.033092719596, 4419.315006174048, 4483.3723278741, 4533.863984080417, 4538.523455037173, 4544.159330523864, 4549.567791059844, 4594.65540084495, 4714.245720684674, 4782.569568738831, 4788.233882578771, 4790.592799611933, 4805.447373552016, 5063.7468126592785, 5098.515641014098, 5112.028714544224, 5120.052790233819, 5126.0, 4833.879153021203, 4840.201366774443, 4846.321514987975, 4867.464578896248, 4886.071646387175, 4924.285978533164, 4935.8025678972435, 5045.646804723634, 5053.772580233972, 5059.747012649426, 5024.497550244946, 5046.697198167974, 5074.416442109205, 5086.21163719624, 5129.128048231735, 4943.134951383566, 4945.109880221451, 4946.653734238569, 4948.183549714401, 4963.652544322007, 4750.406199225097, 4875.1712208923855, 4902.117618828645, 4934.087193869145, 4997.5002499749735, 4834.63740219492, 4847.781849816837, 4862.00328932575, 4888.217885138503, 4903.460619331942, 4951.0, 4962.379702537183, 4971.403431588233, 4976.253561965589, 4978.352814134139, 4710.858674239641, 4773.641976851681, 4807.230843065093, 4845.224764037737, 4913.164761990542], "value": 4610.716664019175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.0428698626471, 581.1515187825775, 585.0580565289882, 603.9577229593929, 622.5579838314796, 35613.64386356139, 36741.81629091858, 39858.0, 39925.800370998106, 40407.0, 40679.38980915289, 41035.0, 41081.17837643245, 41234.175316493725, 41310.79344603273, 7661.042369703801, 7755.8061048473955, 7796.532208067534, 7815.335696465807, 7838.255365740246, 7666.38668906489, 7728.806779830493, 7790.649420776051, 7791.4156438267355, 7812.218778122199, 7771.922280777205, 7791.571463569501, 7835.177306382833, 7844.058712954425, 7861.68553257869, 7725.111612164589, 7775.339096176832, 7782.260685234894, 7784.026996625422, 7808.726694565691, 7670.578118203496, 7701.922980770177, 7704.8844267336035, 7739.9613001935195, 7762.340201082915, 29288.0, 37212.0, 37664.0, 37901.0, 37978.430323545166, 2993.057186986114, 3081.6302043754895, 3151.8896838610767, 3212.4538828399227, 3317.4857897026, 29283.85358073217, 29820.0, 30151.0, 30398.69601304003, 30951.535726964114, 3478.5371083667565, 3510.6489351064943, 3541.1762942084847, 3575.535180426528, 3637.418013117888, 242804.0, 243669.0, 243927.0, 244220.0, 245106.0, 54555.454445455835, 54963.45036549663, 55198.0, 55241.1713824293, 55248.447515525135, 33510.8324458381, 34249.14377140542, 34413.827930860185, 35200.471992920124, 35264.82367588145, 12988.870111298955, 12995.220286782824, 13086.411111500005, 13128.277944713132, 13150.21098734079, 10171.694849154537, 10176.440295783803, 10216.591336346612, 10230.59077636901, 10285.794284114276, 18162.182701778453, 18171.72742408865, 18258.63482730338, 18280.085995700163, 18302.81697183011, 6853.725850966005, 6971.860562788817, 7180.8922866157045, 7184.676689548983, 7191.280871912767, 824.8061705499202, 853.6286715278874, 952.2572393533055, 971.5967873332629, 985.4826216236534, 27150.5927411089, 27201.183964481097, 27598.44803103927, 27991.72008279891, 28006.439871202463, 987.2990176974286, 994.7264502261792, 1035.5909415780875, 1080.3733834376044, 1122.7473818390797, 14360.784588231185, 14627.853721462649, 14820.0, 14857.0, 14890.106593604201, 395614.0, 406660.0, 408031.0, 408320.0, 409996.0, 48355.27467087997, 49365.0, 49767.0, 49890.0, 50000.49999500031, 1206.203905422417, 1210.152892974921, 1217.1479964025218, 1220.8412906322299, 1221.5480272299128, 26681.7331826687, 27353.45293094087, 27631.585526217525, 27859.303517412227, 28017.0, 41159.38260926028, 41780.791096044326, 41994.790026049675, 42069.15861682811, 42240.15519689528, 360260.0, 361994.0, 364419.0, 364690.0, 364723.0, 24437.38906527351, 25594.360140996625, 25643.230703078938, 25705.10032148866, 25758.227253182435, 41543.169136617704, 42214.366784498874, 42832.57167428286, 42867.57132428761, 43529.34705979476, 36592.26815463623, 36938.44592331171, 37144.25711485809, 37246.81376593208, 37559.061023473536, 35863.64136358603, 35968.8201559001, 36401.635983639826, 36870.63129368672, 36913.261734764616, 35521.467177991835, 36098.45852312165, 37105.0, 37260.44109338308, 39021.2195756089, 30574.694253058075, 33511.16222094467, 33659.15852103717, 33816.1545961353, 33889.0, 25587.744122558535, 26034.86982565151, 26314.86842565775, 26321.07876224323, 26524.734752652228], "value": 17418.690506074323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.6487918916623, 372.5454944967139, 376.06360163193636, 384.7383779030258, 390.1416882857712, 15942.123183224918, 16138.19309034548, 16465.34138634453, 16547.58631034225, 16568.58578535537, 15616.453424130157, 15766.605834854134, 16528.09095499747, 16536.090515021668, 16553.503394898173, 5032.220005899073, 5193.662411943231, 5196.3764348278255, 5232.843014709565, 5249.553787928031, 3717.55389353278, 5114.514121158502, 5644.096944488882, 5940.554458415614, 5945.316288626798, 5960.403959604048, 5995.85010374742, 6001.429864162919, 6017.06735456005, 6018.0, 5859.326177489601, 6037.094435834616, 6155.353687862755, 6158.753649854, 6171.074338849164, 5155.432902380772, 5303.787848486056, 5312.787488500456, 5323.733813309319, 5347.732613369316, 19270.0, 19718.21127154912, 19795.802041979685, 19808.504787380287, 19859.205631774712, 1952.160570954489, 1962.8233458988616, 1979.356709069558, 2089.98955005224, 2135.124598914453, 12760.872391276062, 12824.358782060954, 12866.099373043891, 12988.545400911018, 13172.0, 1746.5458980665119, 1786.6516029374277, 1810.9456716298532, 1856.793084495089, 1889.1593241007756, 66687.0, 68060.6596967017, 68165.97751033788, 68182.65908670475, 70001.0, 9273.907260927304, 9509.524523773784, 9528.618855245852, 9644.373115747454, 9717.271204659679, 12889.0, 12915.160514566523, 12918.483260669467, 12925.741485170432, 12997.740045199043, 6675.4325882300545, 6954.756583519553, 6993.755218567428, 7076.823079423056, 7091.574505529685, 6547.508936829757, 6584.407403333723, 6703.698333574904, 6785.1518560179975, 6796.25241223465, 3831.8467261309233, 3869.4582758413844, 4121.361189015707, 4180.602842729936, 4223.535411104776, 1639.6802623488543, 1830.6544689653094, 2979.4190132923873, 3048.527478240876, 3250.837458127084, 855.9015713193063, 898.5686870302292, 911.0661571888735, 926.6988228825659, 968.4867020479157, 15596.84403155954, 16242.350305987628, 16264.0, 16402.09788461646, 16667.49997500077, 857.9742607721778, 890.6062012949712, 910.01263628962, 910.8132832769398, 917.3486824354783, 8941.821163576693, 9188.816223675489, 9190.11602621461, 9340.0, 9427.57575909072, 401647.0, 411836.0, 420257.0, 425785.0, 426865.0, 76365.23634763582, 76927.0, 77993.0, 78717.21282787214, 79027.99999999885, 914.3919293669635, 919.7746552094779, 946.3281070440065, 954.4750387286964, 959.9520023998772, 13614.31928403556, 14361.210133442342, 14489.78265326, 14782.0, 15012.6997460048, 35626.46560301649, 36433.63566364302, 36939.26121477609, 37231.81384093062, 37616.24767504689, 48310.516894832006, 48942.51057489379, 49516.0, 50966.490335096176, 51722.74138629283, 7288.0, 7288.380487658608, 7292.307230813064, 7318.524295920748, 7444.702211911679, 7993.92006079955, 10184.490775461345, 11145.609903653332, 11204.159688023268, 11401.3729244889, 9719.708408747749, 9863.457509837028, 9937.304388692723, 10241.539130738985, 10305.433201173708, 9564.330496865152, 9865.950670246602, 9984.900150998397, 10092.84860727075, 10340.586376544854, 8822.25010874083, 8925.928888533417, 10199.13307368882, 10410.635627752992, 10536.52585633633, 7464.954906313012, 7532.924670753222, 7601.315881570686, 7614.894498136291, 7711.614419278902, 7561.886571701539, 9604.615815367308, 10078.445685487368, 10371.740706482096, 10453.9477302613], "value": 8270.8588518937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.722855428914, 1403.7192561487702, 1478.778183272509, 1717.7766890304258, 1743.6338368942522, 6563.868722625544, 7177.497575169734, 7374.0, 7585.696572137122, 7601.961990190048, 7499.837525183591, 7644.923550764491, 7699.807504812383, 7706.922930770691, 7738.419618528605, 2175.1734340950416, 2209.7790220977936, 2211.7456492503406, 2211.8562293450955, 2218.090582861027, 2176.542925985545, 2210.557888422314, 2212.048819007826, 2222.9110835566557, 2231.1856172497005, 2203.9889800550973, 2206.249875042485, 2212.0930418528405, 2212.2478357358495, 2228.810551103158, 2156.482444213393, 2156.5255643758346, 2160.0, 2162.275637661385, 2165.880876551781, 2148.9462763430884, 2157.557700671359, 2164.4372463159693, 2165.4586353411646, 2171.185805323004, 7676.692932282702, 7711.305982461606, 7715.151333353327, 7715.922840771576, 7720.343770779435, 4316.784160791948, 4413.668974826901, 4434.600885920283, 4474.753888536129, 4486.55134486552, 2758.241483592008, 2869.210966984096, 2887.6967918368478, 2912.053582585668, 2935.5890175375466, 880.6697488441835, 937.4515908193647, 948.0472125513884, 949.3449519831295, 950.6672664567416, 10451.320664156805, 10468.0, 10517.368957862553, 10525.0, 10563.894361056367, 4100.712950093465, 4190.622843944059, 4228.6617070634275, 4237.152569486115, 4269.573042695705, 8964.327675424369, 8965.193132618097, 9012.0, 9055.0, 9071.682491112779, 4391.912161756747, 4432.357308190294, 4446.777661116931, 4448.288273876165, 4454.086912182995, 3425.9314813703586, 3790.50723405961, 3917.882463526099, 3942.9211415772097, 3960.346542820402, 3638.599754027055, 3681.9263614727556, 3738.925221495609, 3756.849726010929, 3885.747426417274, 1180.7815554122344, 1188.441432526711, 1191.1780871198846, 1192.5051103792002, 1192.8270400791837, 862.0861886400436, 867.2628265973872, 887.0552861202798, 887.9955600222087, 896.4934811831295, 5125.231215317732, 5196.610254230948, 5540.196671482612, 5636.802711905064, 5756.194132821408, 835.6114406800867, 883.1830556734994, 919.6643225222879, 935.3265648732902, 937.7280588629358, 3874.12832112778, 3930.0, 3963.246983073207, 3963.900902477461, 3967.0677390813134, 9125.0, 9435.52822358893, 9468.100530449596, 9474.668386606574, 9519.524023798782, 9281.396709214014, 9322.440653560809, 9352.205062569758, 9356.578953946953, 9357.485338306322, 7107.147142342848, 7174.856502869913, 7258.891116633255, 7265.164506081763, 7282.271772822675, 5263.842084737464, 5363.973180134074, 5491.203775452617, 5541.584381171348, 5557.083081291542, 8528.91471085306, 8532.146785321418, 8633.093525179765, 8801.427907186013, 8812.16284452976, 8820.426672266281, 8862.734117976472, 8897.911020889967, 8899.555022248733, 8923.866142008004, 5646.322441306905, 5806.65160090396, 5995.400459954144, 6390.87218255623, 6546.312637173029, 7409.407247420301, 7420.851582968418, 7445.627718614156, 7569.583672898044, 7574.848503030019, 6637.601743895381, 6845.623490708059, 6877.65611719422, 6884.552504087218, 6917.13535808024, 6478.093066970534, 6501.9674901625185, 6530.053142294436, 6573.5069869759, 6584.209894812653, 6198.876022479435, 6239.625622462667, 6274.215723034621, 6277.403646653744, 6277.5605707600025, 4452.666050046195, 4693.577578017995, 4705.670603057753, 4737.786799593958, 4766.761661916821, 4673.639811894971, 4719.0, 4758.833440829693, 4811.591014763644, 4821.686590371614], "value": 4131.708755592848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7351962674713, 290.7514075465477, 294.70823884354485, 298.0091196770738, 299.1369897844719, 4831.4685384607665, 4881.560659540641, 4989.875253118674, 5008.874778130548, 5045.889904221065, 4907.312976183337, 4928.1868491698915, 4940.209566469365, 4942.135126352892, 4950.405951285851, 3864.188520410717, 3893.552241492222, 3902.1025164212247, 3912.8434862605463, 3927.2341893330813, 3606.1525541497726, 3931.272714547818, 3943.5859234780364, 3945.072907866649, 3956.643902048815, 3739.364308067635, 3788.981055094721, 3791.867284645038, 3794.4118661607495, 3810.6760925321382, 3788.621137886203, 3809.8666546670734, 3810.3903375460072, 3817.351050321438, 3821.3503704370046, 3173.9206519836957, 3262.673732626742, 3282.9343413131605, 3338.1821453743746, 3346.9624416430984, 4645.279981602857, 4652.74409907455, 4674.322223277606, 4681.180793361183, 4681.648876334254, 4305.0, 4313.698041137121, 4313.741175529447, 4328.7402755834755, 4330.0, 5103.5151660592555, 5207.661502002357, 5208.739563021833, 5222.8694282642855, 5231.718229033873, 3577.8032208228537, 3593.1196856770257, 3601.333753255656, 3611.0611241077245, 3620.7103431725664, 5410.729463526808, 5443.646162999432, 5457.945420545783, 5487.972560137174, 5500.28496295483, 3685.8894233173046, 3694.4827724118645, 3697.5932647408763, 3704.111013356775, 3706.0, 3622.836972336251, 3776.546814382237, 3779.5464544254864, 3787.5644300905196, 3795.69634429245, 4298.376735373354, 4325.84859529915, 4332.545082766327, 4335.436393268855, 4339.869803905888, 5153.948460515422, 5202.375714914235, 5204.115300398941, 5225.137852254412, 5250.7374631268285, 1228.6928267933017, 1269.5112381732915, 1299.2334522631693, 1303.882650561435, 1307.6730817295677, 801.9894932385237, 815.3517953227199, 829.1294141151767, 840.3906519016138, 840.5923127283263, 4143.274926887782, 4156.521999969982, 4162.958370416318, 4178.0, 4211.263028969979, 4740.573348398591, 4755.643326750507, 4765.26138448541, 4779.689320194177, 4786.736729479842, 4155.633936511435, 4212.7472351659, 4245.344315716873, 4250.129942825147, 4275.828966841292, 2581.889787391402, 2656.2164161571995, 2873.6264285642733, 2907.476654202264, 2910.777473461151, 5099.617528685363, 5102.36220472441, 5108.131617624938, 5157.303763991888, 5169.767360468788, 5278.208268759717, 5506.0, 5514.696691681996, 5551.7779288828, 5562.495627754489, 5066.620003499752, 5080.288759573663, 5090.694558326438, 5097.286379906742, 5133.3326667534475, 5390.110631745718, 5435.2934118564335, 5436.157395603688, 5440.755166017618, 5454.618176727591, 5083.212102124176, 5253.973730131325, 5281.705982034427, 5297.947020529899, 5306.946930530646, 5078.882645817914, 5103.157978933435, 5108.872278193075, 5147.150720131136, 5155.072087024221, 3646.5441819772527, 3676.9080772980888, 3694.7413681042067, 3694.8891533254045, 3705.6850167736043, 5213.270142180022, 5358.598105142208, 5400.486953739545, 5401.8919621606565, 5404.7297635118875, 5177.534021938043, 5182.24857395683, 5186.974065129651, 5202.843914682566, 5209.47905209476, 5143.92284115731, 5180.9740951295, 5188.9740551297, 5189.584833213409, 5233.947660523499, 4901.655470368141, 5077.669951453144, 5088.4148322941855, 5124.974375128249, 5142.331496905378, 5174.689518628894, 5226.163813789927, 5233.947660523499, 5242.947570524246, 5249.08141075318, 5100.974495127501, 5120.283160357479, 5127.564157046693, 5145.867909060001, 5171.120909445479], "value": 3853.8500253820416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3000819131721, 660.9834754131149, 689.5793565924785, 700.4641449291294, 737.7233537423466, 11927.58253461129, 12833.743325133491, 12880.806787898166, 12918.354082295895, 12944.676383090416, 11987.760244795121, 12002.759944801099, 12021.09841761867, 12042.57850975216, 12044.457999390026, 613.9201903752506, 765.3035737478896, 775.3409601838449, 775.6470805783355, 784.1256998446719, 785.2579312549643, 786.0842118931438, 786.3119770201074, 789.3251270164013, 794.5709316968859, 831.7962099285684, 835.2900034970257, 836.2014276366086, 839.2237180607943, 841.2596914715042, 829.1749709039514, 829.9045609754895, 830.667732906836, 832.196929962589, 833.0503226322028, 604.2205554834259, 608.0362625239002, 608.9025755879082, 611.966341851198, 612.5865041097242, 12421.75156496865, 12444.253344799341, 12488.875111248863, 12490.625281241577, 12538.059645526622, 12717.30054846983, 13263.403146858414, 13362.131461454974, 13399.531016414476, 13417.194968301836, 10258.281920265585, 10308.536115874804, 10496.895031049668, 10539.209559283008, 10573.259871808976, 3359.882404115844, 3394.0835974286806, 3433.6738009889023, 3445.1214940190343, 3531.6644918732677, 57955.710221449044, 58817.7059114706, 59260.0, 60689.08966365508, 61414.0, 10518.579256829795, 10530.104941080093, 10597.84103238452, 10730.731731706614, 10934.179936504794, 19864.10611522485, 19928.70106948397, 19961.0, 19993.600127997357, 19994.90002549978, 6627.271000189975, 6882.208546017172, 6980.057692211588, 7017.789466316019, 7022.0520229769345, 3743.42672093649, 3832.4251362295877, 3872.457855900176, 3885.592012838668, 3949.5260568731937, 2877.9712202878122, 2995.026616349695, 2995.670476247611, 3000.219942814884, 3010.864511097006, 511.3148381169251, 525.256761682223, 542.1271752478507, 546.9507744303032, 548.8408361575179, 550.0429253099658, 564.5032371513042, 585.157373382328, 592.863641362489, 608.1273372710086, 7643.197464266172, 7965.721199757981, 8165.774519064936, 8278.503289802631, 8586.65653373858, 575.2780260772787, 576.2681394628798, 578.3724658745224, 578.8032069096528, 579.6782785554058, 3706.3884459064493, 3776.7167462440425, 3916.6670832979516, 3968.583298753647, 3985.362342025262, 79730.60134699405, 88109.0, 89780.5510972454, 91717.0, 92867.53566232126, 53096.0, 78034.6098269505, 78397.60801196072, 81573.9999999988, 84023.0, 68331.3166868335, 69392.6530367345, 69654.65172674104, 69838.3016169842, 70235.6488217566, 7129.500934934505, 7182.425405967615, 7343.375813055736, 7386.482946193715, 7514.774556763306, 34849.82575087108, 43569.78215108904, 44009.0, 44548.109037818416, 44884.0, 60199.39800601938, 60206.0, 60483.39516604954, 60630.696846515486, 60655.0, 9217.585208665492, 9253.537323133682, 9254.0, 9297.535123243946, 9430.481323527272, 10688.893111069101, 10693.09108725767, 10693.251472397169, 10694.41180735067, 10705.304155229886, 9735.1725103367, 9955.601775929172, 10047.949760251153, 10155.492225388552, 10297.330673506198, 9647.372920760128, 9831.213502919893, 10039.146672532917, 10268.691939241835, 10287.94856025745, 9641.27690423207, 9691.2731545133, 9886.950565247127, 9922.40465572068, 10237.027482389161, 8192.18078192176, 8254.42219044661, 8347.415680902279, 8353.24820766134, 8526.658933642833, 7887.723929662434, 8520.105388934073, 8528.317734581095, 8817.470951742916, 8827.24968377695], "value": 6280.748631424961, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 157.0, 191.0, 134.0, 161.0, 157.0, 132.0, 195.0, 138.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 176.0, 162.0, 162.0, 161.0, 163.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 77.0, 77.0, 179.0, 77.0, 76.0, 77.0, 76.0, 166.0, 76.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 146.0, 86.0, 86.0, 86.0, 142.0, 86.0, 85.0, 133.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 67.0, 65.0, 67.0, 65.0, 63.0, 66.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 83.0, 85.0, 90.0, 88.0, 86.0, 85.0, 111.0, 87.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 137.0, 130.0, 136.0, 133.0, 135.0, 135.0, 149.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 167.0, 169.0, 175.0, 173.0, 175.0, 168.0, 166.0, 178.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 67.0, 76.0, 69.0, 67.0, 66.0, 70.0, 67.0], "value": 69.0, "unit": "score"}]}]} 04:56:24 INFO - Return code: 0 04:56:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:24 ERROR - # TBPL SUCCESS # 04:56:24 INFO - Running post-action listener: _resource_record_post_action 04:56:24 INFO - ##### 04:56:24 INFO - ##### Finished run-tests step (success) 04:56:24 INFO - ##### 04:56:24 INFO - Running post-run listener: _resource_record_post_run 04:56:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20480; Write bytes: 534556672; Read time: 24; Write time: 594628 04:56:24 INFO - TinderboxPrint: CPU usage
13.5% 04:56:24 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 24 04:56:24 INFO - TinderboxPrint: I/O write bytes / time
534,556,672 / 594,628 04:56:24 INFO - TinderboxPrint: CPU idle
8,271.3 (86.5%) 04:56:24 INFO - TinderboxPrint: CPU user
1,230.5 (12.9%) 04:56:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237776896; Read time: 0; Write time: 300676 04:56:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 20480; Write bytes: 296779776; Read time: 24; Write time: 293952 04:56:24 INFO - Running post-run listener: _upload_blobber_files 04:56:24 INFO - Blob upload gear active. 04:56:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:24 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 04:56:24 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'] 04:56:24 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 04:56:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:25 INFO - (blobuploader) - INFO - Done attempting. 04:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:26 INFO - (blobuploader) - INFO - Done attempting. 04:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:31 INFO - (blobuploader) - INFO - Done attempting. 04:56:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:31 INFO - Return code: 0 04:56:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56: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/8aedf244023ba2529b157a238e6befec475f60e2ce93a0705ba1cd994db1a74aabd7dd968139aee1c4688bbf4fd0b204181150b143c0b224bd902fd3015ab5ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f84d1d138ab11bcb1ada7df68fda7c22020830908ecb9a1e29736b3c9987ed8daa4adeeb1fc45a8d165ff5d9b1174c0f81c4acacfb61803b5963043f2886056", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c74a148e1dd0136e100ccc89d0ef48a3e1207e71a36479462e656f374f0dbee770d16dd3d1b5b46ba25267cff98be650e21227bdcb5241fce591e877d03e90c"} 04:56:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:31 INFO - Contents: 04:56:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aedf244023ba2529b157a238e6befec475f60e2ce93a0705ba1cd994db1a74aabd7dd968139aee1c4688bbf4fd0b204181150b143c0b224bd902fd3015ab5ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f84d1d138ab11bcb1ada7df68fda7c22020830908ecb9a1e29736b3c9987ed8daa4adeeb1fc45a8d165ff5d9b1174c0f81c4acacfb61803b5963043f2886056", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c74a148e1dd0136e100ccc89d0ef48a3e1207e71a36479462e656f374f0dbee770d16dd3d1b5b46ba25267cff98be650e21227bdcb5241fce591e877d03e90c"} 04:56:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:31 INFO - Copying logs to upload dir... 04:56:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.015628 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 04:56:31.318382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 04:56:31.321986) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 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/8aedf244023ba2529b157a238e6befec475f60e2ce93a0705ba1cd994db1a74aabd7dd968139aee1c4688bbf4fd0b204181150b143c0b224bd902fd3015ab5ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f84d1d138ab11bcb1ada7df68fda7c22020830908ecb9a1e29736b3c9987ed8daa4adeeb1fc45a8d165ff5d9b1174c0f81c4acacfb61803b5963043f2886056", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c74a148e1dd0136e100ccc89d0ef48a3e1207e71a36479462e656f374f0dbee770d16dd3d1b5b46ba25267cff98be650e21227bdcb5241fce591e877d03e90c"} build_url:https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/SNTBiOedQJGKsDNpcRWBqA/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/8aedf244023ba2529b157a238e6befec475f60e2ce93a0705ba1cd994db1a74aabd7dd968139aee1c4688bbf4fd0b204181150b143c0b224bd902fd3015ab5ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f84d1d138ab11bcb1ada7df68fda7c22020830908ecb9a1e29736b3c9987ed8daa4adeeb1fc45a8d165ff5d9b1174c0f81c4acacfb61803b5963043f2886056", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c74a148e1dd0136e100ccc89d0ef48a3e1207e71a36479462e656f374f0dbee770d16dd3d1b5b46ba25267cff98be650e21227bdcb5241fce591e877d03e90c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 04:56:31.350916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:56:31.351493) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465299349.28324-481123743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 04:56:31.434961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 04:56:31.435334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 04:56:31.435726) ========= ========= Total master_lag: 0.19 =========