builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1466597236.16 results: success (0) buildid: 20160622023033 builduid: e2a0309dcb61499e8896316cbf6a664b revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.163657) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.164152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.164468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.201479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.201824) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 05:07:16-- 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% 221M=0s 2016-06-22 05:07:16 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130967 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.558126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.558452) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.609887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:16.613301) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1746be133dff55de7588c846aaafbc30534b8bd --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 a1746be133dff55de7588c846aaafbc30534b8bd --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=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 05:07:16,841 truncating revision to first 12 chars 2016-06-22 05:07:16,841 Setting DEBUG logging. 2016-06-22 05:07:16,841 attempt 1/10 2016-06-22 05:07:16,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1746be133df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 05:07:17,325 unpacking tar archive at: fx-team-a1746be133df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.829213 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:17.462281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:17.462710) ========= script_repo_revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:17.463172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:17.463531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:17.474913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 05:07:17.475248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:17 INFO - MultiFileLogger online at 20160622 05:07:17 in /builds/slave/test 05:07:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:17 INFO - {'append_to_log': False, 05:07:17 INFO - 'base_work_dir': '/builds/slave/test', 05:07:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:17 INFO - 'branch': 'Fx-Team', 05:07:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:17 INFO - 'config_files': ('talos/linux_config.py',), 05:07:17 INFO - 'default_actions': ('clobber', 05:07:17 INFO - 'read-buildbot-config', 05:07:17 INFO - 'download-and-extract', 05:07:17 INFO - 'populate-webroot', 05:07:17 INFO - 'create-virtualenv', 05:07:17 INFO - 'install', 05:07:17 INFO - 'run-tests'), 05:07:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:17 INFO - 'download_minidump_stackwalk': True, 05:07:17 INFO - 'download_symbols': 'ondemand', 05:07:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:17 INFO - 'installer_path': 'installer.exe', 05:07:17 INFO - 'log_level': 'info', 05:07:17 INFO - 'log_name': 'talos', 05:07:17 INFO - 'log_to_console': True, 05:07:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:17 INFO - 'opt_config_files': (), 05:07:17 INFO - 'pip_index': False, 05:07:17 INFO - 'sps_profile': False, 05:07:17 INFO - 'sps_profile_interval': 0, 05:07:17 INFO - 'suite': 'dromaeojs-e10s', 05:07:17 INFO - 'system_bits': '32', 05:07:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:17 INFO - 'title': 'talos-linux64-ix-037', 05:07:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:17 INFO - 'use_talos_json': True, 05:07:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:17 INFO - 'work_dir': 'build'} 05:07:17 INFO - ##### 05:07:17 INFO - ##### Running clobber step. 05:07:17 INFO - ##### 05:07:17 INFO - Running pre-action listener: _resource_record_pre_action 05:07:17 INFO - Running main action method: clobber 05:07:17 INFO - rmtree: /builds/slave/test/build 05:07:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:18 INFO - Running post-action listener: _resource_record_post_action 05:07:18 INFO - ##### 05:07:18 INFO - ##### Finished clobber step (success) 05:07:18 INFO - ##### 05:07:18 INFO - ##### 05:07:18 INFO - ##### Running read-buildbot-config step. 05:07:18 INFO - ##### 05:07:18 INFO - Running pre-action listener: _resource_record_pre_action 05:07:18 INFO - Running main action method: read_buildbot_config 05:07:18 INFO - Using buildbot properties: 05:07:18 INFO - { 05:07:18 INFO - "project": "", 05:07:18 INFO - "product": "firefox", 05:07:18 INFO - "script_repo_revision": "production", 05:07:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:07:18 INFO - "repository": "", 05:07:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:07:18 INFO - "buildid": "20160622023033", 05:07:18 INFO - "pgo_build": "True", 05:07:18 INFO - "basedir": "/builds/slave/test", 05:07:18 INFO - "buildnumber": 855, 05:07:18 INFO - "slavename": "talos-linux64-ix-037", 05:07:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:07:18 INFO - "platform": "ubuntu64_hw", 05:07:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:18 INFO - "branch": "fx-team", 05:07:18 INFO - "repo_path": "integration/fx-team", 05:07:18 INFO - "revision": "a1746be133dff55de7588c846aaafbc30534b8bd", 05:07:18 INFO - "stage_platform": "linux64-pgo", 05:07:18 INFO - "builduid": "e2a0309dcb61499e8896316cbf6a664b", 05:07:18 INFO - "slavebuilddir": "test" 05:07:18 INFO - } 05:07:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:07:18 INFO - Running post-action listener: _resource_record_post_action 05:07:18 INFO - ##### 05:07:18 INFO - ##### Finished read-buildbot-config step (success) 05:07:18 INFO - ##### 05:07:18 INFO - ##### 05:07:18 INFO - ##### Running download-and-extract step. 05:07:18 INFO - ##### 05:07:18 INFO - Running pre-action listener: _resource_record_pre_action 05:07:18 INFO - Running main action method: download_and_extract 05:07:18 INFO - mkdir: /builds/slave/test/build/tests 05:07: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')]} 05:07:18 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:20 INFO - Downloaded 1361 bytes. 05:07:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:20 INFO - Using the following test package requirements: 05:07:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'jsshell-linux-x86_64.zip'], 05:07:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:20 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:22 INFO - Downloaded 24268127 bytes. 05:07:22 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'] 05:07:22 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 05:07:23 INFO - Return code: 0 05:07:23 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 05:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:23 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:24 INFO - Downloaded 24268127 bytes. 05:07:24 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'] 05:07:24 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 05:07:25 INFO - Return code: 0 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:27 INFO - Downloaded 14405384 bytes. 05:07:27 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'] 05:07:27 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 05:07:27 INFO - Return code: 0 05:07:27 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')]} 05:07:27 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 05:07:30 INFO - Downloaded 60133052 bytes. 05:07:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:30 INFO - mkdir: /builds/slave/test/properties 05:07:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:30 INFO - Contents: 05:07:30 INFO - build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - Running post-action listener: set_extra_try_arguments 05:07:30 INFO - ##### 05:07:30 INFO - ##### Finished download-and-extract step (success) 05:07:30 INFO - ##### 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running populate-webroot step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: populate_webroot 05:07:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:30 INFO - '--tppagecycles', 05:07:30 INFO - '7'], 05:07:30 INFO - 'tests': ['tsvgm']}}, 05:07:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['damp', 'tps']}, 05:07:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'tests': ['damp', 'tps']}, 05:07:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['dromaeo_dom']}, 05:07:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['basic_compositor_video']}, 05:07:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['a11yr', 05:07:30 INFO - 'ts_paint', 05:07:30 INFO - 'tpaint', 05:07:30 INFO - 'sessionrestore', 05:07:30 INFO - 'sessionrestore_no_auto_restore', 05:07:30 INFO - 'tabpaint']}, 05:07:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['tsvgx', 05:07:30 INFO - 'tsvgr_opacity', 05:07:30 INFO - 'tart', 05:07:30 INFO - 'tscrollx', 05:07:30 INFO - 'cart']}, 05:07:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:30 INFO - 'tsvgr_opacity', 05:07:30 INFO - 'tart', 05:07:30 INFO - 'tscrollx', 05:07:30 INFO - 'cart']}, 05:07:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'talos_options': ['--disable-e10s'], 05:07:30 INFO - 'tests': ['tp5o']}, 05:07:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'tests': ['tp5o']}, 05:07:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'talos_options': ['--disable-e10s', 05:07:30 INFO - '--xperf_path', 05:07:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:30 INFO - 'tests': ['tp5n']}, 05:07:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:30 INFO - 'talos_options': ['--xperf_path', 05:07:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:30 INFO - 'tests': ['tp5n']}}, 05:07:30 INFO - 'talos.zip': {'path': '', 05:07:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - ##### 05:07:30 INFO - ##### Finished populate-webroot step (success) 05:07:30 INFO - ##### 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running create-virtualenv step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: create_virtualenv 05:07:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:30 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 05:07:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:31 INFO - Using real prefix '/usr' 05:07:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:33 INFO - Installing pip.................done. 05:07:33 INFO - Return code: 0 05:07:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:33 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')]} 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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')]} 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:33 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 05:07:33 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 05:07:33 INFO - Using env: {'DISPLAY': ':0', 05:07:33 INFO - 'HOME': '/home/cltbld', 05:07:33 INFO - 'LANG': 'en_US.UTF-8', 05:07:33 INFO - 'LANGUAGE': 'en_US:en', 05:07:33 INFO - 'LOGNAME': 'cltbld', 05:07:33 INFO - 'MAIL': '/var/mail/cltbld', 05:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:33 INFO - 'MOZ_NO_REMOTE': '1', 05:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:33 INFO - 'NO_EM_RESTART': '1', 05:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:33 INFO - 'PWD': '/builds/slave/test', 05:07:33 INFO - 'SHELL': '/bin/bash', 05:07:33 INFO - 'SHLVL': '1', 05:07:33 INFO - 'TERM': 'linux', 05:07:33 INFO - 'TMOUT': '86400', 05:07:33 INFO - 'USER': 'cltbld', 05:07:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:33 INFO - '_': '/tools/buildbot/bin/python'} 05:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:33 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 05:07:33 INFO - Cleaning up... 05:07:33 INFO - Return code: 0 05:07:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:33 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')]} 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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')]} 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:33 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 05:07:33 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 05:07:33 INFO - Using env: {'DISPLAY': ':0', 05:07:33 INFO - 'HOME': '/home/cltbld', 05:07:33 INFO - 'LANG': 'en_US.UTF-8', 05:07:33 INFO - 'LANGUAGE': 'en_US:en', 05:07:33 INFO - 'LOGNAME': 'cltbld', 05:07:33 INFO - 'MAIL': '/var/mail/cltbld', 05:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:33 INFO - 'MOZ_NO_REMOTE': '1', 05:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:33 INFO - 'NO_EM_RESTART': '1', 05:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:33 INFO - 'PWD': '/builds/slave/test', 05:07:33 INFO - 'SHELL': '/bin/bash', 05:07:33 INFO - 'SHLVL': '1', 05:07:33 INFO - 'TERM': 'linux', 05:07:33 INFO - 'TMOUT': '86400', 05:07:33 INFO - 'USER': 'cltbld', 05:07:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:33 INFO - '_': '/tools/buildbot/bin/python'} 05:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:33 INFO - Downloading/unpacking psutil>=3.1.1 05:07:33 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 05:07:33 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 05:07:33 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 05:07:33 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 05:07:33 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 05:07:33 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 05:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:35 INFO - Installing collected packages: psutil 05:07:35 INFO - Running setup.py install for psutil 05:07:36 INFO - building 'psutil._psutil_linux' extension 05:07:36 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 05:07:36 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 05:07:36 INFO - building 'psutil._psutil_posix' extension 05:07:36 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 05:07:36 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 05:07:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:36 INFO - Successfully installed psutil 05:07:36 INFO - Cleaning up... 05:07:36 INFO - Return code: 0 05:07:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:36 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')]} 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:36 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')]} 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:36 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:36 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 05:07:36 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 05:07:36 INFO - Using env: {'DISPLAY': ':0', 05:07:36 INFO - 'HOME': '/home/cltbld', 05:07:36 INFO - 'LANG': 'en_US.UTF-8', 05:07:36 INFO - 'LANGUAGE': 'en_US:en', 05:07:36 INFO - 'LOGNAME': 'cltbld', 05:07:36 INFO - 'MAIL': '/var/mail/cltbld', 05:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:36 INFO - 'MOZ_NO_REMOTE': '1', 05:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:36 INFO - 'NO_EM_RESTART': '1', 05:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:36 INFO - 'PWD': '/builds/slave/test', 05:07:36 INFO - 'SHELL': '/bin/bash', 05:07:36 INFO - 'SHLVL': '1', 05:07:36 INFO - 'TERM': 'linux', 05:07:36 INFO - 'TMOUT': '86400', 05:07:36 INFO - 'USER': 'cltbld', 05:07:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:36 INFO - '_': '/tools/buildbot/bin/python'} 05:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:36 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 05:07:36 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 05:07:36 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 05:07:36 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 05:07:36 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 05:07:36 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 05:07:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:38 INFO - Installing collected packages: mozsystemmonitor 05:07:38 INFO - Running setup.py install for mozsystemmonitor 05:07:38 INFO - Successfully installed mozsystemmonitor 05:07:38 INFO - Cleaning up... 05:07:38 INFO - Return code: 0 05:07:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:38 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:38 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 05:07:38 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 05:07:38 INFO - Using env: {'DISPLAY': ':0', 05:07:38 INFO - 'HOME': '/home/cltbld', 05:07:38 INFO - 'LANG': 'en_US.UTF-8', 05:07:38 INFO - 'LANGUAGE': 'en_US:en', 05:07:38 INFO - 'LOGNAME': 'cltbld', 05:07:38 INFO - 'MAIL': '/var/mail/cltbld', 05:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:38 INFO - 'MOZ_NO_REMOTE': '1', 05:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:38 INFO - 'NO_EM_RESTART': '1', 05:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:38 INFO - 'PWD': '/builds/slave/test', 05:07:38 INFO - 'SHELL': '/bin/bash', 05:07:38 INFO - 'SHLVL': '1', 05:07:38 INFO - 'TERM': 'linux', 05:07:38 INFO - 'TMOUT': '86400', 05:07:38 INFO - 'USER': 'cltbld', 05:07:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:38 INFO - '_': '/tools/buildbot/bin/python'} 05:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:39 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 05:07:39 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 05:07:39 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 05:07:39 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 05:07:39 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 05:07:39 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 05:07:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:40 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 05:07:40 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 05:07:40 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 05:07:40 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 05:07:40 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 05:07:40 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 05:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:41 INFO - warning: no files found matching '*.txt' 05:07:41 INFO - no previously-included directories found matching 'build' 05:07:41 INFO - no previously-included directories found matching 'dist' 05:07:41 INFO - no previously-included directories found matching '.git*' 05:07:41 INFO - Installing collected packages: jsonschema, functools32 05:07:41 INFO - Running setup.py install for functools32 05:07:41 INFO - warning: no files found matching '*.txt' 05:07:41 INFO - no previously-included directories found matching 'build' 05:07:41 INFO - no previously-included directories found matching 'dist' 05:07:41 INFO - no previously-included directories found matching '.git*' 05:07:41 INFO - Successfully installed jsonschema functools32 05:07:41 INFO - Cleaning up... 05:07:41 INFO - Return code: 0 05:07:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:41 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:41 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 05:07:41 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 05:07:41 INFO - Using env: {'DISPLAY': ':0', 05:07:41 INFO - 'HOME': '/home/cltbld', 05:07:41 INFO - 'LANG': 'en_US.UTF-8', 05:07:41 INFO - 'LANGUAGE': 'en_US:en', 05:07:41 INFO - 'LOGNAME': 'cltbld', 05:07:41 INFO - 'MAIL': '/var/mail/cltbld', 05:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:41 INFO - 'MOZ_NO_REMOTE': '1', 05:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:41 INFO - 'NO_EM_RESTART': '1', 05:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:41 INFO - 'PWD': '/builds/slave/test', 05:07:41 INFO - 'SHELL': '/bin/bash', 05:07:41 INFO - 'SHLVL': '1', 05:07:41 INFO - 'TERM': 'linux', 05:07:41 INFO - 'TMOUT': '86400', 05:07:41 INFO - 'USER': 'cltbld', 05:07:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:41 INFO - '_': '/tools/buildbot/bin/python'} 05:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:41 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 05:07:41 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 05:07:41 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 05:07:41 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 05:07:41 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 05:07:41 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 05:07:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:44 INFO - Downloading docopt-0.6.1.tar.gz 05:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:44 INFO - Running setup.py install for blobuploader 05:07:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:44 INFO - Running setup.py install for requests 05:07:44 INFO - Running setup.py install for docopt 05:07:44 INFO - Successfully installed blobuploader requests docopt 05:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:44 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 05:07:44 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 05:07:44 INFO - Using env: {'DISPLAY': ':0', 05:07:44 INFO - 'HOME': '/home/cltbld', 05:07:44 INFO - 'LANG': 'en_US.UTF-8', 05:07:44 INFO - 'LANGUAGE': 'en_US:en', 05:07:44 INFO - 'LOGNAME': 'cltbld', 05:07:44 INFO - 'MAIL': '/var/mail/cltbld', 05:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:44 INFO - 'MOZ_NO_REMOTE': '1', 05:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:44 INFO - 'NO_EM_RESTART': '1', 05:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:44 INFO - 'PWD': '/builds/slave/test', 05:07:44 INFO - 'SHELL': '/bin/bash', 05:07:44 INFO - 'SHLVL': '1', 05:07:44 INFO - 'TERM': 'linux', 05:07:44 INFO - 'TMOUT': '86400', 05:07:44 INFO - 'USER': 'cltbld', 05:07:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:44 INFO - '_': '/tools/buildbot/bin/python'} 05:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:45 INFO - Running setup.py (path:/tmp/pip-wa2bE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:45 INFO - Running setup.py (path:/tmp/pip-zIYV4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:45 INFO - Running setup.py (path:/tmp/pip-i4oV4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:45 INFO - Running setup.py (path:/tmp/pip-pBXs0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:45 INFO - Running setup.py (path:/tmp/pip-_mCYpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:45 INFO - Running setup.py (path:/tmp/pip-KXguUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:45 INFO - Running setup.py (path:/tmp/pip-QU8Ztb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:45 INFO - Running setup.py (path:/tmp/pip-CsHAVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:45 INFO - Running setup.py (path:/tmp/pip-tWNRa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:45 INFO - Running setup.py (path:/tmp/pip-ODJpx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:45 INFO - Running setup.py (path:/tmp/pip-8JwlWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:45 INFO - Running setup.py (path:/tmp/pip-itBdt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:45 INFO - Running setup.py (path:/tmp/pip-Hhg4Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:46 INFO - Running setup.py (path:/tmp/pip-JRjtMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:46 INFO - Running setup.py (path:/tmp/pip-X8caVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:46 INFO - Running setup.py (path:/tmp/pip-MwNN2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:46 INFO - Running setup.py (path:/tmp/pip-VlyntW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:46 INFO - Running setup.py install for manifestparser 05:07:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:46 INFO - Running setup.py install for mozcrash 05:07:46 INFO - Running setup.py install for mozdebug 05:07:46 INFO - Running setup.py install for mozdevice 05:07:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:46 INFO - Running setup.py install for mozfile 05:07:46 INFO - Running setup.py install for mozhttpd 05:07:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:46 INFO - Running setup.py install for mozinfo 05:07:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for mozInstall 05:07:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for mozleak 05:07:47 INFO - Running setup.py install for mozlog 05:07:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for moznetwork 05:07:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for mozprocess 05:07:47 INFO - Running setup.py install for mozprofile 05:07:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for mozrunner 05:07:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:47 INFO - Running setup.py install for mozscreenshot 05:07:47 INFO - Running setup.py install for moztest 05:07:47 INFO - Running setup.py install for mozversion 05:07:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:48 INFO - Cleaning up... 05:07:48 INFO - Return code: 0 05:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:48 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')]} 05:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 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')]} 05:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:48 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 05:07:48 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 05:07:48 INFO - Using env: {'DISPLAY': ':0', 05:07:48 INFO - 'HOME': '/home/cltbld', 05:07:48 INFO - 'LANG': 'en_US.UTF-8', 05:07:48 INFO - 'LANGUAGE': 'en_US:en', 05:07:48 INFO - 'LOGNAME': 'cltbld', 05:07:48 INFO - 'MAIL': '/var/mail/cltbld', 05:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:48 INFO - 'MOZ_NO_REMOTE': '1', 05:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:48 INFO - 'NO_EM_RESTART': '1', 05:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:48 INFO - 'PWD': '/builds/slave/test', 05:07:48 INFO - 'SHELL': '/bin/bash', 05:07:48 INFO - 'SHLVL': '1', 05:07:48 INFO - 'TERM': 'linux', 05:07:48 INFO - 'TMOUT': '86400', 05:07:48 INFO - 'USER': 'cltbld', 05:07:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:48 INFO - '_': '/tools/buildbot/bin/python'} 05:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:48 INFO - Running setup.py (path:/tmp/pip-Aeru8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:48 INFO - Running setup.py (path:/tmp/pip-z8h9Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:48 INFO - Running setup.py (path:/tmp/pip-RBIygX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:48 INFO - Running setup.py (path:/tmp/pip-fFCE71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:48 INFO - Running setup.py (path:/tmp/pip-JKdIg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:48 INFO - Running setup.py (path:/tmp/pip-Bwedb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:48 INFO - Running setup.py (path:/tmp/pip-ekR8lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:48 INFO - Running setup.py (path:/tmp/pip-ughEXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:48 INFO - Running setup.py (path:/tmp/pip-Sm6DUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:48 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)) 05:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:48 INFO - Running setup.py (path:/tmp/pip-wqxLec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:49 INFO - Running setup.py (path:/tmp/pip-p9n6GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:49 INFO - Running setup.py (path:/tmp/pip-gkBR7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:49 INFO - Running setup.py (path:/tmp/pip-Q24caA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:49 INFO - Running setup.py (path:/tmp/pip-uFDzFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:49 INFO - Running setup.py (path:/tmp/pip-Is_Ot6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:49 INFO - Running setup.py (path:/tmp/pip-1zEkFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:49 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)) 05:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:49 INFO - Running setup.py (path:/tmp/pip-TZVg7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:49 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)) 05:07:49 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)) 05:07:49 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)) 05:07:49 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)) 05:07:49 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)) 05:07:49 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)) 05:07:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:51 INFO - Downloading blessings-1.6.tar.gz 05:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:51 INFO - Installing collected packages: blessings 05:07:51 INFO - Running setup.py install for blessings 05:07:51 INFO - Successfully installed blessings 05:07:51 INFO - Cleaning up... 05:07:51 INFO - Return code: 0 05:07:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:51 INFO - Reading from file tmpfile_stdout 05:07:51 INFO - Current package versions: 05:07:51 INFO - argparse == 1.2.1 05:07:51 INFO - blessings == 1.6 05:07:51 INFO - blobuploader == 1.2.4 05:07:51 INFO - docopt == 0.6.1 05:07:51 INFO - functools32 == 3.2.3-2 05:07:51 INFO - jsonschema == 2.5.1 05:07:51 INFO - manifestparser == 1.1 05:07:51 INFO - mozInstall == 1.12 05:07:51 INFO - mozcrash == 0.17 05:07:51 INFO - mozdebug == 0.1 05:07:51 INFO - mozdevice == 0.48 05:07:51 INFO - mozfile == 1.2 05:07:51 INFO - mozhttpd == 0.7 05:07:51 INFO - mozinfo == 0.9 05:07:51 INFO - mozleak == 0.1 05:07:51 INFO - mozlog == 3.2 05:07:51 INFO - moznetwork == 0.27 05:07:51 INFO - mozprocess == 0.22 05:07:51 INFO - mozprofile == 0.28 05:07:51 INFO - mozrunner == 6.11 05:07:51 INFO - mozscreenshot == 0.1 05:07:51 INFO - mozsystemmonitor == 0.3 05:07:51 INFO - moztest == 0.7 05:07:51 INFO - mozversion == 1.4 05:07:51 INFO - psutil == 3.1.1 05:07:51 INFO - requests == 1.2.3 05:07:51 INFO - wsgiref == 0.1.2 05:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 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 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:51 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 05:07:51 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 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 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)) 05:07:52 INFO - Cleaning up... 05:07:52 INFO - Return code: 0 05:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:07:52 INFO - Using env: {'DISPLAY': ':0', 05:07:52 INFO - 'HOME': '/home/cltbld', 05:07:52 INFO - 'LANG': 'en_US.UTF-8', 05:07:52 INFO - 'LANGUAGE': 'en_US:en', 05:07:52 INFO - 'LOGNAME': 'cltbld', 05:07:52 INFO - 'MAIL': '/var/mail/cltbld', 05:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:52 INFO - 'MOZ_NO_REMOTE': '1', 05:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:52 INFO - 'NO_EM_RESTART': '1', 05:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:52 INFO - 'PWD': '/builds/slave/test', 05:07:52 INFO - 'SHELL': '/bin/bash', 05:07:52 INFO - 'SHLVL': '1', 05:07:52 INFO - 'TERM': 'linux', 05:07:52 INFO - 'TMOUT': '86400', 05:07:52 INFO - 'USER': 'cltbld', 05:07:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:52 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:52 INFO - Cleaning up... 05:07:52 INFO - Return code: 0 05:07:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb32df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', '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 05:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:07:52 INFO - Using env: {'DISPLAY': ':0', 05:07:52 INFO - 'HOME': '/home/cltbld', 05:07:52 INFO - 'LANG': 'en_US.UTF-8', 05:07:52 INFO - 'LANGUAGE': 'en_US:en', 05:07:52 INFO - 'LOGNAME': 'cltbld', 05:07:52 INFO - 'MAIL': '/var/mail/cltbld', 05:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:52 INFO - 'MOZ_NO_REMOTE': '1', 05:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:52 INFO - 'NO_EM_RESTART': '1', 05:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:52 INFO - 'PWD': '/builds/slave/test', 05:07:52 INFO - 'SHELL': '/bin/bash', 05:07:52 INFO - 'SHLVL': '1', 05:07:52 INFO - 'TERM': 'linux', 05:07:52 INFO - 'TMOUT': '86400', 05:07:52 INFO - 'USER': 'cltbld', 05:07:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:52 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 INFO - Downloading/unpacking flake8 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:55 INFO - no previously-included directories found matching 'docs/_build' 05:07:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:55 INFO - Running setup.py install for pep8 05:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:55 INFO - no previously-included directories found matching 'docs/_build' 05:07:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Running post-action listener: _resource_record_post_action 05:07:55 INFO - Running post-action listener: _start_resource_monitoring 05:07:55 INFO - Starting resource monitoring. 05:07:55 INFO - ##### 05:07:55 INFO - ##### Finished create-virtualenv step (success) 05:07:55 INFO - ##### 05:07:55 INFO - ##### 05:07:55 INFO - ##### Running install step. 05:07:55 INFO - ##### 05:07:55 INFO - Running pre-action listener: _resource_record_pre_action 05:07:55 INFO - Running main action method: install 05:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:55 INFO - Reading from file tmpfile_stdout 05:07:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:55 INFO - Reading from file tmpfile_stdout 05:07:55 INFO - Output received: 05:07:55 INFO - Usage: mozinstall [options] installer 05:07:55 INFO - Options: 05:07:55 INFO - -h, --help show this help message and exit 05:07:55 INFO - -d DEST, --destination=DEST 05:07:55 INFO - Directory to install application into. [default: 05:07:55 INFO - "/builds/slave/test"] 05:07:55 INFO - --app=APP Application being installed. [default: firefox] 05:07:55 INFO - mkdir: /builds/slave/test/build/application 05:07:55 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'] 05:07:55 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 05:08:12 INFO - Reading from file tmpfile_stdout 05:08:12 INFO - Output received: 05:08:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:12 INFO - Running post-action listener: _resource_record_post_action 05:08:12 INFO - ##### 05:08:12 INFO - ##### Finished install step (success) 05:08:12 INFO - ##### 05:08:12 INFO - ##### 05:08:12 INFO - ##### Running run-tests step. 05:08:12 INFO - ##### 05:08:12 INFO - Running pre-action listener: _resource_record_pre_action 05:08:12 INFO - Running main action method: run_tests 05:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:12 INFO - Python 2.7.3 05:08:12 INFO - Return code: 0 05:08:12 INFO - grabbing minidump binary from tooltool 05:08:12 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')]} 05:08:12 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 0x1efb1c0>, '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 0x1efc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:12 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 05:08:12 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 05:08:12 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 05:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:12 INFO - Return code: 0 05:08:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:13 INFO - Return code: 0 05:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:08:13 INFO - Using env: {'DISPLAY': ':0', 05:08:13 INFO - 'HOME': '/home/cltbld', 05:08:13 INFO - 'LANG': 'en_US.UTF-8', 05:08:13 INFO - 'LANGUAGE': 'en_US:en', 05:08:13 INFO - 'LOGNAME': 'cltbld', 05:08:13 INFO - 'MAIL': '/var/mail/cltbld', 05:08:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:13 INFO - 'MOZ_NO_REMOTE': '1', 05:08:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:13 INFO - 'NO_EM_RESTART': '1', 05:08:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:13 INFO - 'PWD': '/builds/slave/test', 05:08:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:13 INFO - 'SHELL': '/bin/bash', 05:08:13 INFO - 'SHLVL': '1', 05:08:13 INFO - 'TERM': 'linux', 05:08:13 INFO - 'TMOUT': '86400', 05:08:13 INFO - 'USER': 'cltbld', 05:08:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559', 05:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:13 INFO - '_': '/tools/buildbot/bin/python'} 05:08:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:08:14 INFO - mozversion application_buildid: 20160622023033 05:08:14 INFO - mozversion application_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 05:08:14 INFO - mozversion application_display_name: Nightly 05:08:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:14 INFO - mozversion application_name: Firefox 05:08:14 INFO - mozversion application_remotingname: firefox 05:08:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:14 INFO - mozversion application_vendor: Mozilla 05:08:14 INFO - mozversion application_version: 50.0a1 05:08:14 INFO - mozversion platform_buildid: 20160622023033 05:08:14 INFO - mozversion platform_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 05:08:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:14 INFO - mozversion platform_version: 50.0a1 05:08:14 INFO - using testdate: 1466597294 05:08:14 INFO - actual date: 1466597294 05:08:14 INFO - starting webserver on 'localhost:40561' 05:08:14 INFO - SUITE-START | Running 2 tests 05:08:14 INFO - TEST-START | dromaeo_css 05:08:14 INFO - operating with platform_type : linux_ 05:08:14 INFO - Initialising browser for dromaeo_css test... 05:08:14 INFO - TEST-INFO | started process 14309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PsdLt/profile http://localhost:40561/getInfo.html) 05:08:18 INFO - PROCESS | 14309 | __metrics Screen width/height:1600/1200 05:08:18 INFO - PROCESS | 14309 | colorDepth:24 05:08:18 INFO - PROCESS | 14309 | Browser inner width/height: 1024/697 05:08:18 INFO - PROCESS | 14309 | __metrics 05:08:19 ERROR - PROCESS | 14309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:08:20 INFO - TEST-INFO | 14309: exit 0 05:08:20 INFO - Browser initialized. 05:08:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:20 INFO - TEST-INFO | started process 14430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PsdLt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:32 INFO - PROCESS | 14430 | RSS: Main: 184442880 05:08:32 INFO - PROCESS | 14430 | 05:09:21 INFO - PROCESS | 14430 | 1466597361911 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] 05:11:29 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40561/tests/dromaeo/cssquery-ext.html) 05:11:30 INFO - PROCESS | 14430 | RSS: Main: 188403712 05:11:30 INFO - PROCESS | 14430 | 05:14:32 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-ext.html (next: http://localhost:40561/tests/dromaeo/cssquery-jquery.html) 05:14:33 INFO - PROCESS | 14430 | RSS: Main: 187785216 05:14:33 INFO - PROCESS | 14430 | 05:17:35 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40561/tests/dromaeo/cssquery-mootools.html) 05:17:35 INFO - PROCESS | 14430 | RSS: Main: 188489728 05:17:35 INFO - PROCESS | 14430 | 05:20:37 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40561/tests/dromaeo/cssquery-prototype.html) 05:20:38 INFO - PROCESS | 14430 | RSS: Main: 186863616 05:20:38 INFO - PROCESS | 14430 | 05:23:40 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40561/tests/dromaeo/cssquery-yui.html) 05:23:41 INFO - PROCESS | 14430 | RSS: Main: 188223488 05:23:41 INFO - PROCESS | 14430 | 05:26:43 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:40561/tests/dromaeo/cssquery-yui.html (next: http://localhost:40561/tests/dromaeo/cssquery-dojo.html) 05:26:44 INFO - PROCESS | 14430 | RSS: Main: 189337600 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | __start_tp_report 05:26:44 INFO - PROCESS | 14430 | _x_x_mozilla_page_load 05:26:44 INFO - PROCESS | 14430 | _x_x_mozilla_page_load_details 05:26:44 INFO - PROCESS | 14430 | |i|pagename|runs| 05:26:44 INFO - PROCESS | 14430 | |0;dojo.html;3102.410541997022;3110.3001824589464;3132.404843079816;3141.7800753947217;3147.9370412591747;5396.055690254205;5407.432219616942;5431.266778984836;5476.890462190754;5477.698726570037;5327.706976116312;5334.333208348957;5369.865753356158;5405.756740946657;5409.29679141712;4857.077155340492;4888.902221955559;4987.850364489053;5045.091883460976;5080.263361812535;802.8881640437864;4898.657094003421;5007.649464537484;5032.949670503303;5055.443901170886;4898.338724272231;4949.8020079196785;4974.626902982272;4979.103761322978;5026.798928042874;4831.637627177975;4959.752012399365;4960.280759289883;4977.253411988195;4993.525615066563;4874.439439464471;4881.609471242292;4886.462489126193;4889.608831293488;4889.902201955976;5416.620836541444;5476.972615136899;5482.314710661168;5488.25908502355;5538.0585300499015;5716.3426205986425;5772.076467765138;5815.302163740336;5836.737346819404;5860.736266868002;5781.19063331134;5841.532677385799;5849.590528662995;5873.177755114288;5881.000229960874;5426.674399536001;5470.507654311092;5478.91781623276;5480.068388373946;5482.314710661168;5854.970725146432;5896.439838215363;5935.495482883917;5960.433758792908;5995.640261584319;5712;5747.683877386784;5747.885042299131;5748.223989761329;5753;5845.210896528999;5846.035404158351;5847.766089356378;5848.181254624356;5851.122331650201;5666.716664166775;5759;5808.912866307009;5837.562182836305;5873.882522349614;5669.31968163823;5769;5773.797917072882;5805.912911306334;5872.2366092408565;4412.0955204183065;4413.646908247332;4430.579094985971;4439.089986552749;4486.439195100613;3920.4119382092913;3920.627540383659;3929.44987701722;3977.463042489285;3979.92040159201;5618.073017952074;5618.129189975479;5645.604807663424;5650.378458369576;5715.399883012224;5736.225609542742;5865.94134058654;5923.733431995571;5932.762689492458;5937.732802023919;5546.195801608744;5589;5622.8313150605545;5635.492805647511;5651.519620832193;4891.902161956741;4914.33656456381;4925.13810083234;4941.925871111936;4987.127252730757;5809.5352371811;5996.8800623988145;6122.051082082285;6138.07928810673;6154.292256390572;5855.619384739978;5872.236609240771;5904.202932604044;5910.615809972338;5937.7921772737745;5951.702414879325;5970;5996.970015150071;6024.307204671343;6030.1256317832795;5607.046802043744;5745.712714364348;5778.393268706894;5791.507721843691;5815.41845815415;5945.554083443672;5950.732217050157;5957.821265362046;5963.850903727268;6004.189434426296;5768.884622307446;5807.883842323045;5813.069908814569;5817.505512031525;5829.59192856496;5578.77684892616;5703.401142880104;5744.368119506935;5745.224394706661;5763.933672270643;5527.944720552743;5529.115341545334;5586.636868603528;5638.971805140948;5674.801381951612;5691.630044047124;5739.253896993364;5748.511376533042;5752.137179422953;5777.653340799566;5612.607117501899;5619.7752089917585;5621.325440947113;5624.915626265692;5650.067738823048 05:26:44 INFO - PROCESS | 14430 | |1;ext.html;577.7688924430228;616.6824085595919;635.2504045226631;638.6934271549657;645.522313488019;36576.268474630495;40945.795271023606;41022.38466422998;41138.79430602847;41142.794286028606;41354.37968430469;41669.58330416695;41768.164636707246;42038.789806050925;42092;8594.312455003601;8778.122187781235;8780.078091800366;8790;8818.603162857687;8663.610137543825;8687.348448866329;8721.912780872206;8728.345374096936;8747.781305467382;8817.603207855662;8821.691240806573;8825.779355516099;8832;8865.290776737878;8697.695580654678;8722.869156962619;8751.912480875206;8754.824903501894;8755.73732788011;8708.433951793113;8805.471671699719;8829.69096081634;8835.734927952171;8841.778955526099;40607.7969610153;40715.38926916099;40899.386509202384;40910.59089409097;41120;3577.409727394977;3601.891943241707;3722.4788529605607;3771.830267637963;3775.6035616260174;32392.35215295681;32731.18172045694;33013.50479742806;33103.147848384484;33136.3372732544;4537.675077715294;4577.908441831145;4636.675432719711;4677.906441871178;4713.363695901044;334502;334543;335384;336556.99999999756;339704;33986.660133398844;35179;59906.400935990954;60208.89268875656;60429.39570604238;36312.636873631454;36998.445023324675;37032.259354812755;37055.25889482195;37164;13138.408771605109;13212.141210821266;13255.668608284677;13299.335033248299;13322.800157997637;11609.651710448532;11705.414729263503;11716.355600442057;11724.648260552198;11737.471813768401;8363.16368363171;8372.079071302274;8384.413091083565;8457.112003239694;8542.658293668308;3241.5299781531544;3296.175956010997;3297.5383446317533;3312.734981201498;3354.9496757548654;1057.006413970865;1070.9196810239264;1094.9069329106956;1142.8400023996646;1144.9866867822038;32802.17994550108;32943.50584741231;33128.83435582807;33339.83330083334;33742.8312858439;1070.1224995503767;1079.4171147580375;1141.8743938166795;1187.4834447015576;1261.9369031548385;16714.247858846382;17192.398266060627;17275.88582530828;17423.303067877143;17583.29666813313;511797;514320;516499;517550;519676;58699.70650146722;58743.706281468316;58902.41097589055;59257.40742592605;59284;1310.4037662863375;1353.4045020191281;1360.6054244269249;1373.6909195430949;1382.1499777636682;30999.69000309968;32062.67937320597;32163.839180804884;32259.838700807286;32620.83689581537;51801;51988;52006;52177.217341739146;52198.21702674387;416961;418114;420360;421877;424096;28357.291067723472;28431.857840710665;28924;28957.131286061453;29006;49014.264786027525;49772.75113624553;49810;50296;50487.24269135892;41758.37362439626;42180.25828321149;42300.78849605732;42955;43422;41393.58606413897;41669.958251043965;41859.7907010463;42512.78743606262;42569.14861702687;40993.79503102465;41999.1600168001;42680.57319426766;43072.35391469193;45353.773231134954;33762.66237337694;37131.443028355134;37334;39922;40617;28406.573901391082;28812.135635930954;28918.855405722836;29175.562366564092;29220.561691574218 05:26:44 INFO - PROCESS | 14430 | |2;jquery.html;378.48903979627505;384.31399951087315;395.60439560439556;398.6153362005664;403.9454673619061;17359.132043397825;18934.90532547337;19259.614807703838;19504.41486755396;19584.314548990787;18576.349827756032;19100.42698719037;19133.33033343833;19383.321583744535;19544.31594894179;5546.057170281052;5679.4036626154275;5740.368559458477;5759.308882934033;5788.247527821377;5680.545556355502;5680.545556355502;5694.601377903548;5694.715264236792;5714.25714657094;5450.427705090968;5494.80768173114;5608.130739735348;5652;5659.320881494205;5549.084401073818;5558.277423934863;5580.693061881595;5594.580406469531;5615.438456154393;4931.457539670633;4971.527704868032;5060.063888180698;5071.644984851062;5073.315102461157;22550.77449225503;22787.658185127235;23100.53798924029;23392.883035584713;23725.05099796006;2519.9920031987167;2761.144045345949;2821.8730157142977;3054.312779624589;3128.3274096069454;14441.35013924376;14606.707865842624;14729.263536823222;14971.550853474413;14991.32539035746;1930.7007413850877;2007.026592102829;2042.8570000099999;2051.507638166829;2052.969205461919;55654.44345556533;70495.64752176206;71728.28271717268;82804;86815;9859.47178187382;10170;10475.580976760844;10799.514021869034;10813.18901082422;14414.567562973127;14570;14618.780718289021;14637.121772693672;14640.04839685417;7382.446316526282;7676.846463070708;7686.923130768732;7741.535507869546;7791.493552919155;7259.201487836333;7397.482176247719;7432.851342973218;7476.214997425301;7507.587082710504;6403.3276505966205;6426.007937539378;6477.1579694639395;6478.574713563009;6623.668816559153;1884.387574038443;1918.7793403758747;1926.4702206892937;1945.6789629711222;1954.853385996056;908.5411867007119;986.7187851462298;992.265723364705;1011.9443430611387;1130.2083852883366;17841.46475605734;19851.702224466644;19881.502962426053;20018.89990550038;20156.596868062556;979.8138353712915;994.8706668133096;995.0944640377222;997.1922742578535;1012.9493525323704;10937.781244375068;11353.318800871974;11466;11635.069194464422;11636.301821890544;447349;457120;459327;471060;502217;74642.64108115148;84880.57559712161;85423.57288213643;86059.56970215109;86601.5669921659;967.1682353176403;986.1026465916125;1008.5612758450097;1013.8175128476945;1022.7647641042453;17444.91277543604;17470.30118795285;17495.562610934827;17710.20304086345;17867.821321787134;38936;39777.40333894936;40068.59931400765;41587.376189356575;42329;52522.73738631282;54695;56110.438895610525;57029.14456283242;57199;8761.956190219009;8785.824283514166;8896.619284671784;9054.773630659023;9123.087691230823;12894;13895.444182232597;13944.930275348559;14168.43326266979;14168.574942751733;12208.45061972231;12345.814812777637;12453.501859925864;12530.248185108923;12785.954247320384;12115.697107572381;12170.695732606755;12344.444499997342;12511.12422130442;12623.305718185587;12677.112602117762;12692.682682933;12868.356582170667;12939.935300323437;13096.410661520064;8959.148880856308;9046.457212567268;9130.817383652422;9182.989871114038;9322.067793220624;9632.325737198329;12134.211276267368;12190.085743569445;12683.87316126827;12726 05:26:44 INFO - PROCESS | 14430 | |3;mootools.html;1466.948656797012;1484.235618656392;1622.3591681285893;1732.7487514310433;1747.0740507531004;7807.141214466405;8665.17680820321;8680.869786953193;9189.632414703412;9193.58628861702;8862.24670902974;9015.098490150982;9092.272618190545;9121.315901307395;9172.174504294611;2158.3309174155984;2194.078487035441;2200.471886747177;2204.9228277010307;2213.9557208855813;2153.5369895472472;2154.3644624835633;2190.9452263693374;2232.6762619420174;2235.4523141830273;2270.591293567157;2273.0566814771933;2278.737945136314;2294.472271377584;2322.2336628912503;2221.8889055547156;2235.7987781099696;2236.0608544411307;2241.4620491082187;2244.887755612213;2253.425376528991;2278.4190031542016;2282.7603101674417;2290.3472510334473;2291.6104262275453;9088.68189613367;9130.95434522823;9213.861792073125;9215.723528294095;9217.953910230473;5065.873353166164;5157.767900444489;5200.609954253408;5217.5565076968505;5226.634135610509;3173.2860106476087;3267.836608169582;3431.4166591679473;3464;3465.2722928184858;1097.0839349143475;1107.4684151607273;1109.606089838112;1138.516130644481;1166.3876464855935;12534.122611417204;12627.43176557057;12637.49450021998;12640.873591264153;12661.683457913534;4545.545445455494;4620.53794620542;4660.627149828006;4689.202835517902;4690.132325519789;10646.627368042082;10690.251682382313;10693.144548436107;10717.624883129052;10724.624638137784;5212.687238765686;5216.035033518811;5218.478152184827;5221.791128354899;5229.607779416559;4210.179015092028;4592.425946756655;4726.527347265246;4729.787159577827;4835.468098509161;3970.960290397059;3985.6811455083525;4067.8576249831112;4122.299209134454;4240.533541310453;1269.0862578943147;1298.6688394459352;1298.7597294500547;1309.2733532889338;1318.6835159561829;883.8232353529191;885.9335549833788;995.7610173558294;1011.2718842433436;1025.8717660292464;6107.389261073857;6157.599756015845;6191.5665903387235;6297.96851015742;6390.488760899117;988.9851652225223;997.5560875410373;1007.5868893753526;1013.5894962540183;1027.219313321866;4107.075907920754;4217.325227963511;4249.511306199826;4276.850310239127;4323;10412.375257484575;10777.299475534066;10820.350778953289;10830.512626931806;10883.292585981886;10620.150387968944;10624.990625890528;10627.36235825853;10654.307470014424;10679.519421626046;8129.878051829227;8163.79590510242;8302.501849889026;8334.583270836434;8382.87425688615;6170.413810687977;6193.4425901669065;6233.345498722569;6273.498120150468;6308.08532762756;10251.641192558225;10308.536115874653;10323.32898361604;10458.477076146315;10483.52824122901;9537.427754334762;9939.105480506789;9939.850902236327;10198.43908585035;10220.591176352862;7190.173130089897;7581.279778421042;7730.806729831575;7907.327877130509;8098.595070246346;8744.956275218583;8774.078721734126;8832.955835220782;8838.248748856418;8860.158284962918;7696;7827.491213071132;7848.7645370638975;7916.010498687664;8210.425270231026;7984.361251100015;8090.514569125871;8102.189781021851;8107.71622993216;8153.7553873383895;7211.459140564583;7252.601106939169;7306.744263950736;7335.046443962251;7405.148407933157;5242.711650859239;5254.185601231662;5297.920531191958;5304.07178743726;5330.173823057432;4973.378327709036;5017.867406352359;5047.4700156484505;5130.4100028497205;5130.79476820923 05:26:44 INFO - PROCESS | 14430 | |4;prototype.html;319.82889154302455;323.92711639881014;325.3509249048149;325.6808327838718;327.6608709985165;5673.220122140153;5708.771649134035;5729.598928075036;5751.827445176641;5773.826785196446;5586.804461843836;5602.991461536922;5622.4939755422;5639.646484843639;5684.346300175481;4154.605312495316;4168.416421700964;4313.525512193672;4321.438213032301;4330.328799036154;4298.849540266091;4307.849225277116;4313.525512193656;4336.869893903188;4338.956610433903;4288.914221715564;4305.526392096866;4307.267764480046;4315.395844581745;4327.63215126713;4099.405586190001;4234.407182994383;4269.978650106761;4291;4355.695101342907;3659.8170091495585;3698;3744.9625503744887;3752.9624703752884;3762.7611571115144;5453.64551304164;5472.699001554913;5472.781088756485;5477.972610136963;5501.862453438696;4862.513748625109;4883.609311255126;4969.130402179604;4974.129527332739;4997.800087996476;5825.883482330372;5840.7079646017955;5844.707764611795;5857.824265272048;5858.593937455023;4127.174565086964;4138.544760076389;4140.399642051885;4145.316022856225;4160.188763191179;5864.941350586482;6128;6188.226471691039;6197.783077592263;6223.408776166302;4174.853880114181;4185.895352616209;4202.936955945664;4227.767472788964;4289.305724238908;4214.136102099063;4215;4216.8313267469575;4249.553796851348;4304.80628371724;4666.370040044619;4902.4362198346935;4934.827281045146;4942.233953737176;4946.455889852114;5862.501687356537;5867.70661466925;5877.177195192677;5894.381089985575;5917.319508256605;1456.0826679192253;1463.0855715178013;1477.1580199286304;1484.4952716076587;1487.843776403462;924.4453328003144;929.693201243588;951.8810148731409;982.4841957972122;985.7382550335582;5663.660180389107;5699.375677931769;5700;5709.286339207599;5712.942870571324;5965.28416590012;6021.397860213943;6033.125196846433;6066.423689749555;6070.696465176724;5388.97913282519;5667.1782591524825;5732.254806875079;5744.454276843693;5775.740091695884;3239.319742854027;3259.429599820022;3269.166362577575;3279.212988882651;3284.819334936554;6087.269527656621;6217.544070092288;6222.253329600477;6306.810795676137;6419.49141951641;6178.382161783786;6234.251889773256;6236.906446403307;6238.625682459067;6280.811575652738;6007.969960150172;6238.875222495525;6255.155554000152;6262.152664963846;6291.96854015727;5969.925488373405;6017.759289628541;6053.156245783871;6072.392760724069;6079.905616988807;5905.498032667271;5958.314793798769;5967.582269241285;5967.940320596738;6003.609765365237;5945.286565612154;6153.753849845956;6163.274283200711;6233.75064997395;6316.463100636497;4180.665546756191;4188.560201178954;4221.366794980655;4263.808128634157;4264.466941632296;5796.478316951495;5941.851453713692;5944.791932282349;6034.788782392595;6117.143599895929;5823.621464604787;5871.970640146772;5884.852453771645;5906.557008224315;5914.704264786657;5858.47273745365;5877.265341832271;5900.203472531325;5925.555583331354;5927.170196172453;5516.089845175501;5644;5750.769969201185;5757.136429535603;5768.913466297925;5751.4536119068625;5898.528117750656;5937.109433584997;5937.19847820556;5942;5432.511074003359;5768;5781.624194427349;5811.79658711943;5826.92201942642 05:26:44 INFO - PROCESS | 14430 | |5;yui.html;735.8491509240605;742.9665665045072;787.8030492376906;842.6757923575639;853.5348235211811;15173.468928587488;16419.507414777545;16718.83281167188;16831.831681683194;16844.66310673786;14925.104493730356;15256.084634921912;15291.311890964906;15299.464518741846;15306.387744490206;657.0899304463329;778.5289899610739;783.8549868274359;804.264098350012;811.4036183405193;773.9187385324544;783.1698399696312;786.3709032773787;790.4190420041265;794;839.7858546070773;842.658723217095;846.826400587878;847.3348421489133;847.6990668312752;834.4742812028444;838.7357982235576;841.6170642357744;842.5408152556871;844.5228445928032;608.7808388979963;609.1137395090133;609.9939000610026;610.0483246135998;610.4048552661164;14466.927665361605;14477.927610361881;14479.203643799587;14499.565013049625;14513.492027779082;14606.12363258208;15445.691086178214;15511.922440387838;15527;15820.367185312574;12511.436985335682;12567.434465448985;12638.55765048228;12665.556705515262;13090.214587124803;3861.015441062539;3905.3556163233034;3912.100216950089;3940.389239667856;4023.6378725914515;75629.77328161857;76125;78956.60521697355;79155;79399;11653.983382819035;11906.642800715992;11933.76132477363;12090.818637720442;12116.27302361861;22965.311040668807;22999.310020699406;23047.769522304563;23069;23171.652425213637;8463.703770368007;8718.86921696175;8743.91256087431;8869.866951995726;8921.643134274556;4806.7836947337455;4852.636052296092;4884.3650325458175;4918.2376731606655;4952.975235123801;3442.2599141184264;3518.8240587971013;3548.2193917338145;3557.2351944332095;3571.160777217352;605.7183409714504;608.592243197059;613.3774219167549;622.7415622516695;622.9657368844757;723.9529430586995;740.8333125046821;742.6472425597906;764.1288930619098;770.6878714120678;9131.99548049714;9316.767080822898;9365.203957663674;9408.247340212767;9541.379810312308;618.7689962081793;658.7397977798838;685.9333736040405;707.6355676826438;739.1241378965835;4263.978680106579;4397.428334316518;4435.467743870756;4504.1216962692615;4529.139463501924;112036;115880;116679.41660291645;116870;117390.41304793592;101601;104489;104680.47659761652;105878.470607648;106291.46854265835;56802;82349.58825205955;84704;85566;86616;8542.957285213533;8645.8703119452;8656.610452529525;8713.215810577078;8731.825363492822;49876;50576;50688.493115069854;50716.74641626916;50992.74503627458;65932;73837;75286;75619.62190189013;75636.62181689276;12266.570670026505;12361.567345142877;12497.375131243583;12571.93714031424;12652.051096167641;13318.800217996932;14035.157890526601;14060;14512.419503220175;14715.779263311273;12308.507659693512;12611.621651350475;12927.030472714772;13301.406225785879;13752.724945501233;12968.351582420653;13015.739685206432;13183.340832958505;13188.538401155913;13515.662108447368;12773.489060437478;12930.935345323212;13059.477620895057;13325.400951885837;13613.38739756733;9444.197243234126;9659;9691.563879625293;9824.901750982399;10292.330998485075;9199.908000919904;9488.810223795623;9562.665306714232;10352.689419317432;10355.07664168263 05:26:44 INFO - PROCESS | 14430 | __end_tp_report 05:26:44 INFO - PROCESS | 14430 | __start_cc_report 05:26:44 INFO - PROCESS | 14430 | _x_x_mozilla_cycle_collect,349 05:26:44 INFO - PROCESS | 14430 | __end_cc_report 05:26:44 INFO - PROCESS | 14430 | __startTimestamp1466598404119__endTimestamp 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | ------- Summary: start ------- 05:26:44 INFO - PROCESS | 14430 | Number of tests: 6 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#0] dojo.html Cycles:165 Average:5397.32 Median:5650.38 stddev:724.74 (12.8%) stddev-sans-first:704.25 05:26:44 INFO - PROCESS | 14430 | Values: 3102.4 3110.3 3132.4 3141.8 3147.9 5396.1 5407.4 5431.3 5476.9 5477.7 5327.7 5334.3 5369.9 5405.8 5409.3 4857.1 4888.9 4987.9 5045.1 5080.3 802.9 4898.7 5007.6 5032.9 5055.4 4898.3 4949.8 4974.6 4979.1 5026.8 4831.6 4959.8 4960.3 4977.3 4993.5 4874.4 4881.6 4886.5 4889.6 4889.9 5416.6 5477.0 5482.3 5488.3 5538.1 5716.3 5772.1 5815.3 5836.7 5860.7 5781.2 5841.5 5849.6 5873.2 5881.0 5426.7 5470.5 5478.9 5480.1 5482.3 5855.0 5896.4 5935.5 5960.4 5995.6 5712.0 5747.7 5747.9 5748.2 5753.0 5845.2 5846.0 5847.8 5848.2 5851.1 5666.7 5759.0 5808.9 5837.6 5873.9 5669.3 5769.0 5773.8 5805.9 5872.2 4412.1 4413.6 4430.6 4439.1 4486.4 3920.4 3920.6 3929.4 3977.5 3979.9 5618.1 5618.1 5645.6 5650.4 5715.4 5736.2 5865.9 5923.7 5932.8 5937.7 5546.2 5589.0 5622.8 5635.5 5651.5 4891.9 4914.3 4925.1 4941.9 4987.1 5809.5 5996.9 6122.1 6138.1 6154.3 5855.6 5872.2 5904.2 5910.6 5937.8 5951.7 5970.0 5997.0 6024.3 6030.1 5607.0 5745.7 5778.4 5791.5 5815.4 5945.6 5950.7 5957.8 5963.9 6004.2 5768.9 5807.9 5813.1 5817.5 5829.6 5578.8 5703.4 5744.4 5745.2 5763.9 5527.9 5529.1 5586.6 5639.0 5674.8 5691.6 5739.3 5748.5 5752.1 5777.7 5612.6 5619.8 5621.3 5624.9 5650.1 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#1] ext.html Cycles:180 Average:57612.45 Median:41129.40 stddev:114203.57 (277.7%) stddev-sans-first:114443.66 05:26:44 INFO - PROCESS | 14430 | Values: 577.8 616.7 635.3 638.7 645.5 36576.3 40945.8 41022.4 41138.8 41142.8 41354.4 41669.6 41768.2 42038.8 42092.0 8594.3 8778.1 8780.1 8790.0 8818.6 8663.6 8687.3 8721.9 8728.3 8747.8 8817.6 8821.7 8825.8 8832.0 8865.3 8697.7 8722.9 8751.9 8754.8 8755.7 8708.4 8805.5 8829.7 8835.7 8841.8 40607.8 40715.4 40899.4 40910.6 41120.0 3577.4 3601.9 3722.5 3771.8 3775.6 32392.4 32731.2 33013.5 33103.1 33136.3 4537.7 4577.9 4636.7 4677.9 4713.4 334502.0 334543.0 335384.0 336557.0 339704.0 33986.7 35179.0 59906.4 60208.9 60429.4 36312.6 36998.4 37032.3 37055.3 37164.0 13138.4 13212.1 13255.7 13299.3 13322.8 11609.7 11705.4 11716.4 11724.6 11737.5 8363.2 8372.1 8384.4 8457.1 8542.7 3241.5 3296.2 3297.5 3312.7 3354.9 1057.0 1070.9 1094.9 1142.8 1145.0 32802.2 32943.5 33128.8 33339.8 33742.8 1070.1 1079.4 1141.9 1187.5 1261.9 16714.2 17192.4 17275.9 17423.3 17583.3 511797.0 514320.0 516499.0 517550.0 519676.0 58699.7 58743.7 58902.4 59257.4 59284.0 1310.4 1353.4 1360.6 1373.7 1382.1 30999.7 32062.7 32163.8 32259.8 32620.8 51801.0 51988.0 52006.0 52177.2 52198.2 416961.0 418114.0 420360.0 421877.0 424096.0 28357.3 28431.9 28924.0 28957.1 29006.0 49014.3 49772.8 49810.0 50296.0 50487.2 41758.4 42180.3 42300.8 42955.0 43422.0 41393.6 41670.0 41859.8 42512.8 42569.1 40993.8 41999.2 42680.6 43072.4 45353.8 33762.7 37131.4 37334.0 39922.0 40617.0 28406.6 28812.1 28918.9 29175.6 29220.6 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#2] jquery.html Cycles:180 Average:28075.12 Median:19660.16 stddev:76885.13 (391.1%) stddev-sans-first:77072.69 05:26:44 INFO - PROCESS | 14430 | Values: 378.5 384.3 395.6 398.6 403.9 17359.1 18934.9 19259.6 19504.4 19584.3 18576.3 19100.4 19133.3 19383.3 19544.3 5546.1 5679.4 5740.4 5759.3 5788.2 5680.5 5680.5 5694.6 5694.7 5714.3 5450.4 5494.8 5608.1 5652.0 5659.3 5549.1 5558.3 5580.7 5594.6 5615.4 4931.5 4971.5 5060.1 5071.6 5073.3 22550.8 22787.7 23100.5 23392.9 23725.1 2520.0 2761.1 2821.9 3054.3 3128.3 14441.4 14606.7 14729.3 14971.6 14991.3 1930.7 2007.0 2042.9 2051.5 2053.0 55654.4 70495.6 71728.3 82804.0 86815.0 9859.5 10170.0 10475.6 10799.5 10813.2 14414.6 14570.0 14618.8 14637.1 14640.0 7382.4 7676.8 7686.9 7741.5 7791.5 7259.2 7397.5 7432.9 7476.2 7507.6 6403.3 6426.0 6477.2 6478.6 6623.7 1884.4 1918.8 1926.5 1945.7 1954.9 908.5 986.7 992.3 1011.9 1130.2 17841.5 19851.7 19881.5 20018.9 20156.6 979.8 994.9 995.1 997.2 1012.9 10937.8 11353.3 11466.0 11635.1 11636.3 447349.0 457120.0 459327.0 471060.0 502217.0 74642.6 84880.6 85423.6 86059.6 86601.6 967.2 986.1 1008.6 1013.8 1022.8 17444.9 17470.3 17495.6 17710.2 17867.8 38936.0 39777.4 40068.6 41587.4 42329.0 52522.7 54695.0 56110.4 57029.1 57199.0 8762.0 8785.8 8896.6 9054.8 9123.1 12894.0 13895.4 13944.9 14168.4 14168.6 12208.5 12345.8 12453.5 12530.2 12786.0 12115.7 12170.7 12344.4 12511.1 12623.3 12677.1 12692.7 12868.4 12939.9 13096.4 8959.1 9046.5 9130.8 9183.0 9322.1 9632.3 12134.2 12190.1 12683.9 12726.0 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#3] mootools.html Cycles:180 Average:5871.08 Median:4640.58 stddev:3357.67 (72.4%) stddev-sans-first:3350.78 05:26:44 INFO - PROCESS | 14430 | Values: 1466.9 1484.2 1622.4 1732.7 1747.1 7807.1 8665.2 8680.9 9189.6 9193.6 8862.2 9015.1 9092.3 9121.3 9172.2 2158.3 2194.1 2200.5 2204.9 2214.0 2153.5 2154.4 2190.9 2232.7 2235.5 2270.6 2273.1 2278.7 2294.5 2322.2 2221.9 2235.8 2236.1 2241.5 2244.9 2253.4 2278.4 2282.8 2290.3 2291.6 9088.7 9131.0 9213.9 9215.7 9218.0 5065.9 5157.8 5200.6 5217.6 5226.6 3173.3 3267.8 3431.4 3464.0 3465.3 1097.1 1107.5 1109.6 1138.5 1166.4 12534.1 12627.4 12637.5 12640.9 12661.7 4545.5 4620.5 4660.6 4689.2 4690.1 10646.6 10690.3 10693.1 10717.6 10724.6 5212.7 5216.0 5218.5 5221.8 5229.6 4210.2 4592.4 4726.5 4729.8 4835.5 3971.0 3985.7 4067.9 4122.3 4240.5 1269.1 1298.7 1298.8 1309.3 1318.7 883.8 885.9 995.8 1011.3 1025.9 6107.4 6157.6 6191.6 6298.0 6390.5 989.0 997.6 1007.6 1013.6 1027.2 4107.1 4217.3 4249.5 4276.9 4323.0 10412.4 10777.3 10820.4 10830.5 10883.3 10620.2 10625.0 10627.4 10654.3 10679.5 8129.9 8163.8 8302.5 8334.6 8382.9 6170.4 6193.4 6233.3 6273.5 6308.1 10251.6 10308.5 10323.3 10458.5 10483.5 9537.4 9939.1 9939.9 10198.4 10220.6 7190.2 7581.3 7730.8 7907.3 8098.6 8745.0 8774.1 8833.0 8838.2 8860.2 7696.0 7827.5 7848.8 7916.0 8210.4 7984.4 8090.5 8102.2 8107.7 8153.8 7211.5 7252.6 7306.7 7335.0 7405.1 5242.7 5254.2 5297.9 5304.1 5330.2 4973.4 5017.9 5047.5 5130.4 5130.8 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#4] prototype.html Cycles:180 Average:4930.42 Median:5711.11 stddev:1476.02 (25.8%) stddev-sans-first:1439.02 05:26:44 INFO - PROCESS | 14430 | Values: 319.8 323.9 325.4 325.7 327.7 5673.2 5708.8 5729.6 5751.8 5773.8 5586.8 5603.0 5622.5 5639.6 5684.3 4154.6 4168.4 4313.5 4321.4 4330.3 4298.8 4307.8 4313.5 4336.9 4339.0 4288.9 4305.5 4307.3 4315.4 4327.6 4099.4 4234.4 4270.0 4291.0 4355.7 3659.8 3698.0 3745.0 3753.0 3762.8 5453.6 5472.7 5472.8 5478.0 5501.9 4862.5 4883.6 4969.1 4974.1 4997.8 5825.9 5840.7 5844.7 5857.8 5858.6 4127.2 4138.5 4140.4 4145.3 4160.2 5864.9 6128.0 6188.2 6197.8 6223.4 4174.9 4185.9 4202.9 4227.8 4289.3 4214.1 4215.0 4216.8 4249.6 4304.8 4666.4 4902.4 4934.8 4942.2 4946.5 5862.5 5867.7 5877.2 5894.4 5917.3 1456.1 1463.1 1477.2 1484.5 1487.8 924.4 929.7 951.9 982.5 985.7 5663.7 5699.4 5700.0 5709.3 5712.9 5965.3 6021.4 6033.1 6066.4 6070.7 5389.0 5667.2 5732.3 5744.5 5775.7 3239.3 3259.4 3269.2 3279.2 3284.8 6087.3 6217.5 6222.3 6306.8 6419.5 6178.4 6234.3 6236.9 6238.6 6280.8 6008.0 6238.9 6255.2 6262.2 6292.0 5969.9 6017.8 6053.2 6072.4 6079.9 5905.5 5958.3 5967.6 5967.9 6003.6 5945.3 6153.8 6163.3 6233.8 6316.5 4180.7 4188.6 4221.4 4263.8 4264.5 5796.5 5941.9 5944.8 6034.8 6117.1 5823.6 5872.0 5884.9 5906.6 5914.7 5858.5 5877.3 5900.2 5925.6 5927.2 5516.1 5644.0 5750.8 5757.1 5768.9 5751.5 5898.5 5937.1 5937.2 5942.0 5432.5 5768.0 5781.6 5811.8 5826.9 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - PROCESS | 14430 | [#5] yui.html Cycles:180 Average:20724.81 Median:4901.30 stddev:30106.62 (614.3%) stddev-sans-first:30153.67 05:26:44 INFO - PROCESS | 14430 | Values: 735.8 743.0 787.8 842.7 853.5 15173.5 16419.5 16718.8 16831.8 16844.7 14925.1 15256.1 15291.3 15299.5 15306.4 657.1 778.5 783.9 804.3 811.4 773.9 783.2 786.4 790.4 794.0 839.8 842.7 846.8 847.3 847.7 834.5 838.7 841.6 842.5 844.5 608.8 609.1 610.0 610.0 610.4 14466.9 14477.9 14479.2 14499.6 14513.5 14606.1 15445.7 15511.9 15527.0 15820.4 12511.4 12567.4 12638.6 12665.6 13090.2 3861.0 3905.4 3912.1 3940.4 4023.6 75629.8 76125.0 78956.6 79155.0 79399.0 11654.0 11906.6 11933.8 12090.8 12116.3 22965.3 22999.3 23047.8 23069.0 23171.7 8463.7 8718.9 8743.9 8869.9 8921.6 4806.8 4852.6 4884.4 4918.2 4953.0 3442.3 3518.8 3548.2 3557.2 3571.2 605.7 608.6 613.4 622.7 623.0 724.0 740.8 742.6 764.1 770.7 9132.0 9316.8 9365.2 9408.2 9541.4 618.8 658.7 685.9 707.6 739.1 4264.0 4397.4 4435.5 4504.1 4529.1 112036.0 115880.0 116679.4 116870.0 117390.4 101601.0 104489.0 104680.5 105878.5 106291.5 56802.0 82349.6 84704.0 85566.0 86616.0 8543.0 8645.9 8656.6 8713.2 8731.8 49876.0 50576.0 50688.5 50716.7 50992.7 65932.0 73837.0 75286.0 75619.6 75636.6 12266.6 12361.6 12497.4 12571.9 12652.1 13318.8 14035.2 14060.0 14512.4 14715.8 12308.5 12611.6 12927.0 13301.4 13752.7 12968.4 13015.7 13183.3 13188.5 13515.7 12773.5 12930.9 13059.5 13325.4 13613.4 9444.2 9659.0 9691.6 9824.9 10292.3 9199.9 9488.8 9562.7 10352.7 10355.1 05:26:44 INFO - PROCESS | 14430 | -------- Summary: end -------- 05:26:44 INFO - PROCESS | 14430 | 05:26:44 INFO - TEST-INFO | 14430: exit 0 05:26:44 INFO - TEST-OK | dromaeo_css | took 1110856ms 05:26:44 INFO - TEST-START | kraken 05:26:44 INFO - operating with platform_type : linux_ 05:26:44 INFO - Initialising browser for kraken test... 05:26:44 INFO - TEST-INFO | started process 14667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR5yUMZ/profile http://localhost:40561/getInfo.html) 05:26:49 INFO - PROCESS | 14667 | __metrics Screen width/height:1600/1200 05:26:49 INFO - PROCESS | 14667 | colorDepth:24 05:26:49 INFO - PROCESS | 14667 | Browser inner width/height: 1024/697 05:26:49 INFO - PROCESS | 14667 | __metrics 05:26:50 ERROR - PROCESS | 14667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:26:51 INFO - TEST-INFO | 14667: exit 0 05:26:51 INFO - Browser initialized. 05:26:51 INFO - Running cycle 1/1 for kraken test... 05:26:51 INFO - TEST-INFO | started process 14786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR5yUMZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:03 INFO - PROCESS | 14786 | RSS: Main: 184995840 05:27:03 INFO - PROCESS | 14786 | 05:27:05 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40561/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:06 INFO - PROCESS | 14786 | RSS: Main: 190410752 05:27:06 INFO - PROCESS | 14786 | 05:27:09 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40561/tests/kraken/driver.html?testName=audio-dft) 05:27:09 INFO - PROCESS | 14786 | RSS: Main: 189984768 05:27:09 INFO - PROCESS | 14786 | 05:27:12 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40561/tests/kraken/driver.html?testName=audio-fft) 05:27:13 INFO - PROCESS | 14786 | RSS: Main: 185208832 05:27:13 INFO - PROCESS | 14786 | 05:27:15 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40561/tests/kraken/driver.html?testName=audio-oscillator) 05:27:16 INFO - PROCESS | 14786 | RSS: Main: 185511936 05:27:16 INFO - PROCESS | 14786 | 05:27:18 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:18 INFO - PROCESS | 14786 | RSS: Main: 185704448 05:27:18 INFO - PROCESS | 14786 | 05:27:21 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40561/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:22 INFO - PROCESS | 14786 | RSS: Main: 185417728 05:27:22 INFO - PROCESS | 14786 | 05:27:26 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40561/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:26 INFO - PROCESS | 14786 | RSS: Main: 184057856 05:27:26 INFO - PROCESS | 14786 | 05:27:29 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40561/tests/kraken/driver.html?testName=json-parse-financial) 05:27:30 INFO - PROCESS | 14786 | RSS: Main: 185122816 05:27:30 INFO - PROCESS | 14786 | 05:27:31 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:32 INFO - PROCESS | 14786 | RSS: Main: 185327616 05:27:32 INFO - PROCESS | 14786 | 05:27:34 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:34 INFO - PROCESS | 14786 | RSS: Main: 186183680 05:27:34 INFO - PROCESS | 14786 | 05:27:36 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:37 INFO - PROCESS | 14786 | RSS: Main: 186339328 05:27:37 INFO - PROCESS | 14786 | 05:27:40 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:40 INFO - PROCESS | 14786 | RSS: Main: 186294272 05:27:40 INFO - PROCESS | 14786 | 05:27:43 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:44 INFO - PROCESS | 14786 | RSS: Main: 186249216 05:27:44 INFO - PROCESS | 14786 | 05:27:45 INFO - PROCESS | 14786 | Cycle 1(1): loaded http://localhost:40561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40561/tests/kraken/driver.html?testName=ai-astar) 05:27:46 INFO - PROCESS | 14786 | RSS: Main: 187457536 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | __start_tp_report 05:27:46 INFO - PROCESS | 14786 | _x_x_mozilla_page_load 05:27:46 INFO - PROCESS | 14786 | _x_x_mozilla_page_load_details 05:27:46 INFO - PROCESS | 14786 | |i|pagename|runs| 05:27:46 INFO - PROCESS | 14786 | |0;ai-astar;111;106;110;110;111;112;112;110;113;110 05:27:46 INFO - PROCESS | 14786 | |1;audio-beat-detection;162;136;158;179;127;165;153;128;182;130 05:27:46 INFO - PROCESS | 14786 | |2;audio-dft;161;161;161;162;165;170;161;163;162;163 05:27:46 INFO - PROCESS | 14786 | |3;audio-fft;76;75;75;162;76;75;75;75;158;77 05:27:46 INFO - PROCESS | 14786 | |4;audio-oscillator;86;85;143;85;85;85;140;86;84;145 05:27:46 INFO - PROCESS | 14786 | |5;imaging-gaussian-blur;118;118;117;117;118;118;119;117;117;117 05:27:46 INFO - PROCESS | 14786 | |6;imaging-darkroom;148;147;151;147;150;147;149;149;147;148 05:27:46 INFO - PROCESS | 14786 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;97;96 05:27:46 INFO - PROCESS | 14786 | |8;json-parse-financial;57;55;56;55;54;54;54;54;54;54 05:27:46 INFO - PROCESS | 14786 | |9;json-stringify-tinderbox;63;62;63;62;62;63;62;65;62;62 05:27:46 INFO - PROCESS | 14786 | |10;stanford-crypto-aes;80;86;80;80;87;83;81;80;114;87 05:27:46 INFO - PROCESS | 14786 | |11;stanford-crypto-ccm;125;122;122;123;130;136;132;129;139;122 05:27:46 INFO - PROCESS | 14786 | |12;stanford-crypto-pbkdf2;161;162;160;163;160;166;161;160;160;163 05:27:46 INFO - PROCESS | 14786 | |13;stanford-crypto-sha256-iterative;67;64;64;67;66;65;63;64;64;62 05:27:46 INFO - PROCESS | 14786 | __end_tp_report 05:27:46 INFO - PROCESS | 14786 | __start_cc_report 05:27:46 INFO - PROCESS | 14786 | _x_x_mozilla_cycle_collect,894 05:27:46 INFO - PROCESS | 14786 | __end_cc_report 05:27:46 INFO - PROCESS | 14786 | __startTimestamp1466598466076__endTimestamp 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | ------- Summary: start ------- 05:27:46 INFO - PROCESS | 14786 | Number of tests: 14 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 05:27:46 INFO - PROCESS | 14786 | Values: 111.0 106.0 110.0 110.0 111.0 112.0 112.0 110.0 113.0 110.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:160.00 stddev:20.75 (13.0%) stddev-sans-first:21.69 05:27:46 INFO - PROCESS | 14786 | Values: 162.0 136.0 158.0 179.0 127.0 165.0 153.0 128.0 182.0 130.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.81 (1.7%) stddev-sans-first:2.89 05:27:46 INFO - PROCESS | 14786 | Values: 161.0 161.0 161.0 162.0 165.0 170.0 161.0 163.0 162.0 163.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:35.65 (47.5%) stddev-sans-first:37.31 05:27:46 INFO - PROCESS | 14786 | Values: 76.0 75.0 75.0 162.0 76.0 75.0 75.0 75.0 158.0 77.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.00 stddev:27.82 (32.7%) stddev-sans-first:28.87 05:27:46 INFO - PROCESS | 14786 | Values: 86.0 85.0 143.0 85.0 85.0 85.0 140.0 86.0 84.0 145.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:27:46 INFO - PROCESS | 14786 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 119.0 117.0 117.0 117.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.42 (1.0%) stddev-sans-first:1.50 05:27:46 INFO - PROCESS | 14786 | Values: 148.0 147.0 151.0 147.0 150.0 147.0 149.0 149.0 147.0 148.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:27:46 INFO - PROCESS | 14786 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 96.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:1.06 (1.9%) stddev-sans-first:0.73 05:27:46 INFO - PROCESS | 14786 | Values: 57.0 55.0 56.0 55.0 54.0 54.0 54.0 54.0 54.0 54.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:27:46 INFO - PROCESS | 14786 | Values: 63.0 62.0 63.0 62.0 62.0 63.0 62.0 65.0 62.0 62.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:82.00 stddev:10.35 (12.6%) stddev-sans-first:10.76 05:27:46 INFO - PROCESS | 14786 | Values: 80.0 86.0 80.0 80.0 87.0 83.0 81.0 80.0 114.0 87.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.50 stddev:6.22 (4.8%) stddev-sans-first:6.50 05:27:46 INFO - PROCESS | 14786 | Values: 125.0 122.0 122.0 123.0 130.0 136.0 132.0 129.0 139.0 122.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:1.96 (1.2%) stddev-sans-first:2.06 05:27:46 INFO - PROCESS | 14786 | Values: 161.0 162.0 160.0 163.0 160.0 166.0 161.0 160.0 160.0 163.0 05:27:46 INFO - PROCESS | 14786 | 05:27:46 INFO - PROCESS | 14786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.65 (2.6%) stddev-sans-first:1.50 05:27:46 INFO - PROCESS | 14786 | Values: 67.0 64.0 64.0 67.0 66.0 65.0 63.0 64.0 64.0 62.0 05:27:46 INFO - PROCESS | 14786 | -------- Summary: end -------- 05:27:46 INFO - PROCESS | 14786 | 05:27:47 INFO - TEST-INFO | 14786: exit 0 05:27:47 INFO - TEST-OK | kraken | took 62163ms 05:27:47 INFO - SUITE-END | took 1173s 05:27:47 INFO - Completed test suite (00:19:33) 05:27:47 INFO - javascript benchmark 05:27:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7268.497855586842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.410541997022, 3110.3001824589464, 3132.404843079816, 3141.7800753947217, 3147.9370412591747, 5396.055690254205, 5407.432219616942, 5431.266778984836, 5476.890462190754, 5477.698726570037, 5327.706976116312, 5334.333208348957, 5369.865753356158, 5405.756740946657, 5409.29679141712, 4857.077155340492, 4888.902221955559, 4987.850364489053, 5045.091883460976, 5080.263361812535, 802.8881640437864, 4898.657094003421, 5007.649464537484, 5032.949670503303, 5055.443901170886, 4898.338724272231, 4949.8020079196785, 4974.626902982272, 4979.103761322978, 5026.798928042874, 4831.637627177975, 4959.752012399365, 4960.280759289883, 4977.253411988195, 4993.525615066563, 4874.439439464471, 4881.609471242292, 4886.462489126193, 4889.608831293488, 4889.902201955976, 5416.620836541444, 5476.972615136899, 5482.314710661168, 5488.25908502355, 5538.0585300499015, 5716.3426205986425, 5772.076467765138, 5815.302163740336, 5836.737346819404, 5860.736266868002, 5781.19063331134, 5841.532677385799, 5849.590528662995, 5873.177755114288, 5881.000229960874, 5426.674399536001, 5470.507654311092, 5478.91781623276, 5480.068388373946, 5482.314710661168, 5854.970725146432, 5896.439838215363, 5935.495482883917, 5960.433758792908, 5995.640261584319, 5712.0, 5747.683877386784, 5747.885042299131, 5748.223989761329, 5753.0, 5845.210896528999, 5846.035404158351, 5847.766089356378, 5848.181254624356, 5851.122331650201, 5666.716664166775, 5759.0, 5808.912866307009, 5837.562182836305, 5873.882522349614, 5669.31968163823, 5769.0, 5773.797917072882, 5805.912911306334, 5872.2366092408565, 4412.0955204183065, 4413.646908247332, 4430.579094985971, 4439.089986552749, 4486.439195100613, 3920.4119382092913, 3920.627540383659, 3929.44987701722, 3977.463042489285, 3979.92040159201, 5618.073017952074, 5618.129189975479, 5645.604807663424, 5650.378458369576, 5715.399883012224, 5736.225609542742, 5865.94134058654, 5923.733431995571, 5932.762689492458, 5937.732802023919, 5546.195801608744, 5589.0, 5622.8313150605545, 5635.492805647511, 5651.519620832193, 4891.902161956741, 4914.33656456381, 4925.13810083234, 4941.925871111936, 4987.127252730757, 5809.5352371811, 5996.8800623988145, 6122.051082082285, 6138.07928810673, 6154.292256390572, 5855.619384739978, 5872.236609240771, 5904.202932604044, 5910.615809972338, 5937.7921772737745, 5951.702414879325, 5970.0, 5996.970015150071, 6024.307204671343, 6030.1256317832795, 5607.046802043744, 5745.712714364348, 5778.393268706894, 5791.507721843691, 5815.41845815415, 5945.554083443672, 5950.732217050157, 5957.821265362046, 5963.850903727268, 6004.189434426296, 5768.884622307446, 5807.883842323045, 5813.069908814569, 5817.505512031525, 5829.59192856496, 5578.77684892616, 5703.401142880104, 5744.368119506935, 5745.224394706661, 5763.933672270643, 5527.944720552743, 5529.115341545334, 5586.636868603528, 5638.971805140948, 5674.801381951612, 5691.630044047124, 5739.253896993364, 5748.511376533042, 5752.137179422953, 5777.653340799566, 5612.607117501899, 5619.7752089917585, 5621.325440947113, 5624.915626265692, 5650.067738823048], "value": 5349.1893671062935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7688924430228, 616.6824085595919, 635.2504045226631, 638.6934271549657, 645.522313488019, 36576.268474630495, 40945.795271023606, 41022.38466422998, 41138.79430602847, 41142.794286028606, 41354.37968430469, 41669.58330416695, 41768.164636707246, 42038.789806050925, 42092.0, 8594.312455003601, 8778.122187781235, 8780.078091800366, 8790.0, 8818.603162857687, 8663.610137543825, 8687.348448866329, 8721.912780872206, 8728.345374096936, 8747.781305467382, 8817.603207855662, 8821.691240806573, 8825.779355516099, 8832.0, 8865.290776737878, 8697.695580654678, 8722.869156962619, 8751.912480875206, 8754.824903501894, 8755.73732788011, 8708.433951793113, 8805.471671699719, 8829.69096081634, 8835.734927952171, 8841.778955526099, 40607.7969610153, 40715.38926916099, 40899.386509202384, 40910.59089409097, 41120.0, 3577.409727394977, 3601.891943241707, 3722.4788529605607, 3771.830267637963, 3775.6035616260174, 32392.35215295681, 32731.18172045694, 33013.50479742806, 33103.147848384484, 33136.3372732544, 4537.675077715294, 4577.908441831145, 4636.675432719711, 4677.906441871178, 4713.363695901044, 334502.0, 334543.0, 335384.0, 336556.99999999756, 339704.0, 33986.660133398844, 35179.0, 59906.400935990954, 60208.89268875656, 60429.39570604238, 36312.636873631454, 36998.445023324675, 37032.259354812755, 37055.25889482195, 37164.0, 13138.408771605109, 13212.141210821266, 13255.668608284677, 13299.335033248299, 13322.800157997637, 11609.651710448532, 11705.414729263503, 11716.355600442057, 11724.648260552198, 11737.471813768401, 8363.16368363171, 8372.079071302274, 8384.413091083565, 8457.112003239694, 8542.658293668308, 3241.5299781531544, 3296.175956010997, 3297.5383446317533, 3312.734981201498, 3354.9496757548654, 1057.006413970865, 1070.9196810239264, 1094.9069329106956, 1142.8400023996646, 1144.9866867822038, 32802.17994550108, 32943.50584741231, 33128.83435582807, 33339.83330083334, 33742.8312858439, 1070.1224995503767, 1079.4171147580375, 1141.8743938166795, 1187.4834447015576, 1261.9369031548385, 16714.247858846382, 17192.398266060627, 17275.88582530828, 17423.303067877143, 17583.29666813313, 511797.0, 514320.0, 516499.0, 517550.0, 519676.0, 58699.70650146722, 58743.706281468316, 58902.41097589055, 59257.40742592605, 59284.0, 1310.4037662863375, 1353.4045020191281, 1360.6054244269249, 1373.6909195430949, 1382.1499777636682, 30999.69000309968, 32062.67937320597, 32163.839180804884, 32259.838700807286, 32620.83689581537, 51801.0, 51988.0, 52006.0, 52177.217341739146, 52198.21702674387, 416961.0, 418114.0, 420360.0, 421877.0, 424096.0, 28357.291067723472, 28431.857840710665, 28924.0, 28957.131286061453, 29006.0, 49014.264786027525, 49772.75113624553, 49810.0, 50296.0, 50487.24269135892, 41758.37362439626, 42180.25828321149, 42300.78849605732, 42955.0, 43422.0, 41393.58606413897, 41669.958251043965, 41859.7907010463, 42512.78743606262, 42569.14861702687, 40993.79503102465, 41999.1600168001, 42680.57319426766, 43072.35391469193, 45353.773231134954, 33762.66237337694, 37131.443028355134, 37334.0, 39922.0, 40617.0, 28406.573901391082, 28812.135635930954, 28918.855405722836, 29175.562366564092, 29220.561691574218], "value": 18861.495617640703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.48903979627505, 384.31399951087315, 395.60439560439556, 398.6153362005664, 403.9454673619061, 17359.132043397825, 18934.90532547337, 19259.614807703838, 19504.41486755396, 19584.314548990787, 18576.349827756032, 19100.42698719037, 19133.33033343833, 19383.321583744535, 19544.31594894179, 5546.057170281052, 5679.4036626154275, 5740.368559458477, 5759.308882934033, 5788.247527821377, 5680.545556355502, 5680.545556355502, 5694.601377903548, 5694.715264236792, 5714.25714657094, 5450.427705090968, 5494.80768173114, 5608.130739735348, 5652.0, 5659.320881494205, 5549.084401073818, 5558.277423934863, 5580.693061881595, 5594.580406469531, 5615.438456154393, 4931.457539670633, 4971.527704868032, 5060.063888180698, 5071.644984851062, 5073.315102461157, 22550.77449225503, 22787.658185127235, 23100.53798924029, 23392.883035584713, 23725.05099796006, 2519.9920031987167, 2761.144045345949, 2821.8730157142977, 3054.312779624589, 3128.3274096069454, 14441.35013924376, 14606.707865842624, 14729.263536823222, 14971.550853474413, 14991.32539035746, 1930.7007413850877, 2007.026592102829, 2042.8570000099999, 2051.507638166829, 2052.969205461919, 55654.44345556533, 70495.64752176206, 71728.28271717268, 82804.0, 86815.0, 9859.47178187382, 10170.0, 10475.580976760844, 10799.514021869034, 10813.18901082422, 14414.567562973127, 14570.0, 14618.780718289021, 14637.121772693672, 14640.04839685417, 7382.446316526282, 7676.846463070708, 7686.923130768732, 7741.535507869546, 7791.493552919155, 7259.201487836333, 7397.482176247719, 7432.851342973218, 7476.214997425301, 7507.587082710504, 6403.3276505966205, 6426.007937539378, 6477.1579694639395, 6478.574713563009, 6623.668816559153, 1884.387574038443, 1918.7793403758747, 1926.4702206892937, 1945.6789629711222, 1954.853385996056, 908.5411867007119, 986.7187851462298, 992.265723364705, 1011.9443430611387, 1130.2083852883366, 17841.46475605734, 19851.702224466644, 19881.502962426053, 20018.89990550038, 20156.596868062556, 979.8138353712915, 994.8706668133096, 995.0944640377222, 997.1922742578535, 1012.9493525323704, 10937.781244375068, 11353.318800871974, 11466.0, 11635.069194464422, 11636.301821890544, 447349.0, 457120.0, 459327.0, 471060.0, 502217.0, 74642.64108115148, 84880.57559712161, 85423.57288213643, 86059.56970215109, 86601.5669921659, 967.1682353176403, 986.1026465916125, 1008.5612758450097, 1013.8175128476945, 1022.7647641042453, 17444.91277543604, 17470.30118795285, 17495.562610934827, 17710.20304086345, 17867.821321787134, 38936.0, 39777.40333894936, 40068.59931400765, 41587.376189356575, 42329.0, 52522.73738631282, 54695.0, 56110.438895610525, 57029.14456283242, 57199.0, 8761.956190219009, 8785.824283514166, 8896.619284671784, 9054.773630659023, 9123.087691230823, 12894.0, 13895.444182232597, 13944.930275348559, 14168.43326266979, 14168.574942751733, 12208.45061972231, 12345.814812777637, 12453.501859925864, 12530.248185108923, 12785.954247320384, 12115.697107572381, 12170.695732606755, 12344.444499997342, 12511.12422130442, 12623.305718185587, 12677.112602117762, 12692.682682933, 12868.356582170667, 12939.935300323437, 13096.410661520064, 8959.148880856308, 9046.457212567268, 9130.817383652422, 9182.989871114038, 9322.067793220624, 9632.325737198329, 12134.211276267368, 12190.085743569445, 12683.87316126827, 12726.0], "value": 9387.795050941708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.948656797012, 1484.235618656392, 1622.3591681285893, 1732.7487514310433, 1747.0740507531004, 7807.141214466405, 8665.17680820321, 8680.869786953193, 9189.632414703412, 9193.58628861702, 8862.24670902974, 9015.098490150982, 9092.272618190545, 9121.315901307395, 9172.174504294611, 2158.3309174155984, 2194.078487035441, 2200.471886747177, 2204.9228277010307, 2213.9557208855813, 2153.5369895472472, 2154.3644624835633, 2190.9452263693374, 2232.6762619420174, 2235.4523141830273, 2270.591293567157, 2273.0566814771933, 2278.737945136314, 2294.472271377584, 2322.2336628912503, 2221.8889055547156, 2235.7987781099696, 2236.0608544411307, 2241.4620491082187, 2244.887755612213, 2253.425376528991, 2278.4190031542016, 2282.7603101674417, 2290.3472510334473, 2291.6104262275453, 9088.68189613367, 9130.95434522823, 9213.861792073125, 9215.723528294095, 9217.953910230473, 5065.873353166164, 5157.767900444489, 5200.609954253408, 5217.5565076968505, 5226.634135610509, 3173.2860106476087, 3267.836608169582, 3431.4166591679473, 3464.0, 3465.2722928184858, 1097.0839349143475, 1107.4684151607273, 1109.606089838112, 1138.516130644481, 1166.3876464855935, 12534.122611417204, 12627.43176557057, 12637.49450021998, 12640.873591264153, 12661.683457913534, 4545.545445455494, 4620.53794620542, 4660.627149828006, 4689.202835517902, 4690.132325519789, 10646.627368042082, 10690.251682382313, 10693.144548436107, 10717.624883129052, 10724.624638137784, 5212.687238765686, 5216.035033518811, 5218.478152184827, 5221.791128354899, 5229.607779416559, 4210.179015092028, 4592.425946756655, 4726.527347265246, 4729.787159577827, 4835.468098509161, 3970.960290397059, 3985.6811455083525, 4067.8576249831112, 4122.299209134454, 4240.533541310453, 1269.0862578943147, 1298.6688394459352, 1298.7597294500547, 1309.2733532889338, 1318.6835159561829, 883.8232353529191, 885.9335549833788, 995.7610173558294, 1011.2718842433436, 1025.8717660292464, 6107.389261073857, 6157.599756015845, 6191.5665903387235, 6297.96851015742, 6390.488760899117, 988.9851652225223, 997.5560875410373, 1007.5868893753526, 1013.5894962540183, 1027.219313321866, 4107.075907920754, 4217.325227963511, 4249.511306199826, 4276.850310239127, 4323.0, 10412.375257484575, 10777.299475534066, 10820.350778953289, 10830.512626931806, 10883.292585981886, 10620.150387968944, 10624.990625890528, 10627.36235825853, 10654.307470014424, 10679.519421626046, 8129.878051829227, 8163.79590510242, 8302.501849889026, 8334.583270836434, 8382.87425688615, 6170.413810687977, 6193.4425901669065, 6233.345498722569, 6273.498120150468, 6308.08532762756, 10251.641192558225, 10308.536115874653, 10323.32898361604, 10458.477076146315, 10483.52824122901, 9537.427754334762, 9939.105480506789, 9939.850902236327, 10198.43908585035, 10220.591176352862, 7190.173130089897, 7581.279778421042, 7730.806729831575, 7907.327877130509, 8098.595070246346, 8744.956275218583, 8774.078721734126, 8832.955835220782, 8838.248748856418, 8860.158284962918, 7696.0, 7827.491213071132, 7848.7645370638975, 7916.010498687664, 8210.425270231026, 7984.361251100015, 8090.514569125871, 8102.189781021851, 8107.71622993216, 8153.7553873383895, 7211.459140564583, 7252.601106939169, 7306.744263950736, 7335.046443962251, 7405.148407933157, 5242.711650859239, 5254.185601231662, 5297.920531191958, 5304.07178743726, 5330.173823057432, 4973.378327709036, 5017.867406352359, 5047.4700156484505, 5130.4100028497205, 5130.79476820923], "value": 4680.124942676289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.82889154302455, 323.92711639881014, 325.3509249048149, 325.6808327838718, 327.6608709985165, 5673.220122140153, 5708.771649134035, 5729.598928075036, 5751.827445176641, 5773.826785196446, 5586.804461843836, 5602.991461536922, 5622.4939755422, 5639.646484843639, 5684.346300175481, 4154.605312495316, 4168.416421700964, 4313.525512193672, 4321.438213032301, 4330.328799036154, 4298.849540266091, 4307.849225277116, 4313.525512193656, 4336.869893903188, 4338.956610433903, 4288.914221715564, 4305.526392096866, 4307.267764480046, 4315.395844581745, 4327.63215126713, 4099.405586190001, 4234.407182994383, 4269.978650106761, 4291.0, 4355.695101342907, 3659.8170091495585, 3698.0, 3744.9625503744887, 3752.9624703752884, 3762.7611571115144, 5453.64551304164, 5472.699001554913, 5472.781088756485, 5477.972610136963, 5501.862453438696, 4862.513748625109, 4883.609311255126, 4969.130402179604, 4974.129527332739, 4997.800087996476, 5825.883482330372, 5840.7079646017955, 5844.707764611795, 5857.824265272048, 5858.593937455023, 4127.174565086964, 4138.544760076389, 4140.399642051885, 4145.316022856225, 4160.188763191179, 5864.941350586482, 6128.0, 6188.226471691039, 6197.783077592263, 6223.408776166302, 4174.853880114181, 4185.895352616209, 4202.936955945664, 4227.767472788964, 4289.305724238908, 4214.136102099063, 4215.0, 4216.8313267469575, 4249.553796851348, 4304.80628371724, 4666.370040044619, 4902.4362198346935, 4934.827281045146, 4942.233953737176, 4946.455889852114, 5862.501687356537, 5867.70661466925, 5877.177195192677, 5894.381089985575, 5917.319508256605, 1456.0826679192253, 1463.0855715178013, 1477.1580199286304, 1484.4952716076587, 1487.843776403462, 924.4453328003144, 929.693201243588, 951.8810148731409, 982.4841957972122, 985.7382550335582, 5663.660180389107, 5699.375677931769, 5700.0, 5709.286339207599, 5712.942870571324, 5965.28416590012, 6021.397860213943, 6033.125196846433, 6066.423689749555, 6070.696465176724, 5388.97913282519, 5667.1782591524825, 5732.254806875079, 5744.454276843693, 5775.740091695884, 3239.319742854027, 3259.429599820022, 3269.166362577575, 3279.212988882651, 3284.819334936554, 6087.269527656621, 6217.544070092288, 6222.253329600477, 6306.810795676137, 6419.49141951641, 6178.382161783786, 6234.251889773256, 6236.906446403307, 6238.625682459067, 6280.811575652738, 6007.969960150172, 6238.875222495525, 6255.155554000152, 6262.152664963846, 6291.96854015727, 5969.925488373405, 6017.759289628541, 6053.156245783871, 6072.392760724069, 6079.905616988807, 5905.498032667271, 5958.314793798769, 5967.582269241285, 5967.940320596738, 6003.609765365237, 5945.286565612154, 6153.753849845956, 6163.274283200711, 6233.75064997395, 6316.463100636497, 4180.665546756191, 4188.560201178954, 4221.366794980655, 4263.808128634157, 4264.466941632296, 5796.478316951495, 5941.851453713692, 5944.791932282349, 6034.788782392595, 6117.143599895929, 5823.621464604787, 5871.970640146772, 5884.852453771645, 5906.557008224315, 5914.704264786657, 5858.47273745365, 5877.265341832271, 5900.203472531325, 5925.555583331354, 5927.170196172453, 5516.089845175501, 5644.0, 5750.769969201185, 5757.136429535603, 5768.913466297925, 5751.4536119068625, 5898.528117750656, 5937.109433584997, 5937.19847820556, 5942.0, 5432.511074003359, 5768.0, 5781.624194427349, 5811.79658711943, 5826.92201942642], "value": 4449.15193102584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8491509240605, 742.9665665045072, 787.8030492376906, 842.6757923575639, 853.5348235211811, 15173.468928587488, 16419.507414777545, 16718.83281167188, 16831.831681683194, 16844.66310673786, 14925.104493730356, 15256.084634921912, 15291.311890964906, 15299.464518741846, 15306.387744490206, 657.0899304463329, 778.5289899610739, 783.8549868274359, 804.264098350012, 811.4036183405193, 773.9187385324544, 783.1698399696312, 786.3709032773787, 790.4190420041265, 794.0, 839.7858546070773, 842.658723217095, 846.826400587878, 847.3348421489133, 847.6990668312752, 834.4742812028444, 838.7357982235576, 841.6170642357744, 842.5408152556871, 844.5228445928032, 608.7808388979963, 609.1137395090133, 609.9939000610026, 610.0483246135998, 610.4048552661164, 14466.927665361605, 14477.927610361881, 14479.203643799587, 14499.565013049625, 14513.492027779082, 14606.12363258208, 15445.691086178214, 15511.922440387838, 15527.0, 15820.367185312574, 12511.436985335682, 12567.434465448985, 12638.55765048228, 12665.556705515262, 13090.214587124803, 3861.015441062539, 3905.3556163233034, 3912.100216950089, 3940.389239667856, 4023.6378725914515, 75629.77328161857, 76125.0, 78956.60521697355, 79155.0, 79399.0, 11653.983382819035, 11906.642800715992, 11933.76132477363, 12090.818637720442, 12116.27302361861, 22965.311040668807, 22999.310020699406, 23047.769522304563, 23069.0, 23171.652425213637, 8463.703770368007, 8718.86921696175, 8743.91256087431, 8869.866951995726, 8921.643134274556, 4806.7836947337455, 4852.636052296092, 4884.3650325458175, 4918.2376731606655, 4952.975235123801, 3442.2599141184264, 3518.8240587971013, 3548.2193917338145, 3557.2351944332095, 3571.160777217352, 605.7183409714504, 608.592243197059, 613.3774219167549, 622.7415622516695, 622.9657368844757, 723.9529430586995, 740.8333125046821, 742.6472425597906, 764.1288930619098, 770.6878714120678, 9131.99548049714, 9316.767080822898, 9365.203957663674, 9408.247340212767, 9541.379810312308, 618.7689962081793, 658.7397977798838, 685.9333736040405, 707.6355676826438, 739.1241378965835, 4263.978680106579, 4397.428334316518, 4435.467743870756, 4504.1216962692615, 4529.139463501924, 112036.0, 115880.0, 116679.41660291645, 116870.0, 117390.41304793592, 101601.0, 104489.0, 104680.47659761652, 105878.470607648, 106291.46854265835, 56802.0, 82349.58825205955, 84704.0, 85566.0, 86616.0, 8542.957285213533, 8645.8703119452, 8656.610452529525, 8713.215810577078, 8731.825363492822, 49876.0, 50576.0, 50688.493115069854, 50716.74641626916, 50992.74503627458, 65932.0, 73837.0, 75286.0, 75619.62190189013, 75636.62181689276, 12266.570670026505, 12361.567345142877, 12497.375131243583, 12571.93714031424, 12652.051096167641, 13318.800217996932, 14035.157890526601, 14060.0, 14512.419503220175, 14715.779263311273, 12308.507659693512, 12611.621651350475, 12927.030472714772, 13301.406225785879, 13752.724945501233, 12968.351582420653, 13015.739685206432, 13183.340832958505, 13188.538401155913, 13515.662108447368, 12773.489060437478, 12930.935345323212, 13059.477620895057, 13325.400951885837, 13613.38739756733, 9444.197243234126, 9659.0, 9691.563879625293, 9824.901750982399, 10292.330998485075, 9199.908000919904, 9488.810223795623, 9562.665306714232, 10352.689419317432, 10355.07664168263], "value": 7475.928725196274, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 110.0, 111.0, 112.0, 112.0, 110.0, 113.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 136.0, 158.0, 179.0, 127.0, 165.0, 153.0, 128.0, 182.0, 130.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 165.0, 170.0, 161.0, 163.0, 162.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 162.0, 76.0, 75.0, 75.0, 75.0, 158.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 143.0, 85.0, 85.0, 85.0, 140.0, 86.0, 84.0, 145.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 151.0, 147.0, 150.0, 147.0, 149.0, 149.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 65.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 80.0, 80.0, 87.0, 83.0, 81.0, 80.0, 114.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 122.0, 123.0, 130.0, 136.0, 132.0, 129.0, 139.0, 122.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 163.0, 160.0, 166.0, 161.0, 160.0, 160.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 67.0, 66.0, 65.0, 63.0, 64.0, 64.0, 62.0], "value": 64.6, "unit": "score"}]}]} 05:27:47 INFO - Return code: 0 05:27:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:47 ERROR - # TBPL SUCCESS # 05:27:47 INFO - Running post-action listener: _resource_record_post_action 05:27:47 INFO - ##### 05:27:47 INFO - ##### Finished run-tests step (success) 05:27:47 INFO - ##### 05:27:47 INFO - Running post-run listener: _resource_record_post_run 05:27:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 559751168; Read time: 0; Write time: 568812 05:27:47 INFO - TinderboxPrint: CPU usage
13.4% 05:27:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:27:47 INFO - TinderboxPrint: I/O write bytes / time
559,751,168 / 568,812 05:27:47 INFO - TinderboxPrint: CPU idle
8,223.3 (86.5%) 05:27:47 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 05:27:47 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253202432; Read time: 0; Write time: 292480 05:27:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293523456; Read time: 0; Write time: 275308 05:27:47 INFO - Running post-run listener: _upload_blobber_files 05:27:47 INFO - Blob upload gear active. 05:27:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:47 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 05:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:49 INFO - (blobuploader) - INFO - Done attempting. 05:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:52 INFO - (blobuploader) - INFO - Done attempting. 05:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:53 INFO - (blobuploader) - INFO - Done attempting. 05:27:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:53 INFO - Return code: 0 05:27:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7163e739e917508892f0c4c9436125ce3fcf4c11b71c0fa99fdb26ed190195e9f39453e20aa1206028eda3edde531399097d25126a036d928b39151ef8bffab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c88f9c51ad0dad5f1505f3a4aef2edcd0383439d11cff00dbebd073b6ae33e3be0bbd38b60607f53d9d360286d58c4fa50e29579de942fca0aa51fbc22064a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91683269943f5ad31b789dcaf7d4a45a5c2f593db58eb42a3007dbd2dcc637a859fb4727903ad207bb2146e7f858f52d678f10cc61f50bc186df432d53a4ab0"} 05:27:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:53 INFO - Contents: 05:27:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7163e739e917508892f0c4c9436125ce3fcf4c11b71c0fa99fdb26ed190195e9f39453e20aa1206028eda3edde531399097d25126a036d928b39151ef8bffab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c88f9c51ad0dad5f1505f3a4aef2edcd0383439d11cff00dbebd073b6ae33e3be0bbd38b60607f53d9d360286d58c4fa50e29579de942fca0aa51fbc22064a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91683269943f5ad31b789dcaf7d4a45a5c2f593db58eb42a3007dbd2dcc637a859fb4727903ad207bb2146e7f858f52d678f10cc61f50bc186df432d53a4ab0"} 05:27:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:53 INFO - Copying logs to upload dir... 05:27:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.025085 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 05:27:53.540338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:27:53.543812) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 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/sha512/7163e739e917508892f0c4c9436125ce3fcf4c11b71c0fa99fdb26ed190195e9f39453e20aa1206028eda3edde531399097d25126a036d928b39151ef8bffab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c88f9c51ad0dad5f1505f3a4aef2edcd0383439d11cff00dbebd073b6ae33e3be0bbd38b60607f53d9d360286d58c4fa50e29579de942fca0aa51fbc22064a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91683269943f5ad31b789dcaf7d4a45a5c2f593db58eb42a3007dbd2dcc637a859fb4727903ad207bb2146e7f858f52d678f10cc61f50bc186df432d53a4ab0"} build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/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/KqrGmej5SOSZZs78nL-_5g/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/sha512/7163e739e917508892f0c4c9436125ce3fcf4c11b71c0fa99fdb26ed190195e9f39453e20aa1206028eda3edde531399097d25126a036d928b39151ef8bffab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c88f9c51ad0dad5f1505f3a4aef2edcd0383439d11cff00dbebd073b6ae33e3be0bbd38b60607f53d9d360286d58c4fa50e29579de942fca0aa51fbc22064a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91683269943f5ad31b789dcaf7d4a45a5c2f593db58eb42a3007dbd2dcc637a859fb4727903ad207bb2146e7f858f52d678f10cc61f50bc186df432d53a4ab0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:27:53.572265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:27:53.572819) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466597005.766574-1833951559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:27:53.654887) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:27:53.655293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:27:53.655639) ========= ========= Total master_lag: 0.41 =========