builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1464764845.93 results: success (0) buildid: 20160531173011 builduid: 08eb6a699884491085b29eb1accfe308 revision: 03d6c612af0ddbf22f4fbe12ad034831be38fab7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:25.932740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:25.933310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:25.933585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:25.976261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:25.976533) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 00:07:26-- 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% 226M=0s 2016-06-01 00:07:26 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112494 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:26.270587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:26.270933) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019968 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:26.328583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:26.328990) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03d6c612af0ddbf22f4fbe12ad034831be38fab7 --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 03d6c612af0ddbf22f4fbe12ad034831be38fab7 --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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 00:07:26,634 truncating revision to first 12 chars 2016-06-01 00:07:26,634 Setting DEBUG logging. 2016-06-01 00:07:26,634 attempt 1/10 2016-06-01 00:07:26,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03d6c612af0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 00:07:27,119 unpacking tar archive at: fx-team-03d6c612af0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828399 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:27.183608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:27.183900) ========= script_repo_revision: 03d6c612af0ddbf22f4fbe12ad034831be38fab7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:27.184262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:27.184530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 00:07:27.193665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 00:07:27.193961) ========= /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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:07:27 INFO - MultiFileLogger online at 20160601 00:07:27 in /builds/slave/test 00:07:27 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 00:07:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:07:27 INFO - {'append_to_log': False, 00:07:27 INFO - 'base_work_dir': '/builds/slave/test', 00:07:27 INFO - 'blob_upload_branch': 'Fx-Team', 00:07:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:07:27 INFO - 'branch': 'Fx-Team', 00:07:27 INFO - 'buildbot_json_path': 'buildprops.json', 00:07:27 INFO - 'config_files': ('talos/linux_config.py',), 00:07:27 INFO - 'default_actions': ('clobber', 00:07:27 INFO - 'read-buildbot-config', 00:07:27 INFO - 'download-and-extract', 00:07:27 INFO - 'populate-webroot', 00:07:27 INFO - 'create-virtualenv', 00:07:27 INFO - 'install', 00:07:27 INFO - 'run-tests'), 00:07:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:07:27 INFO - 'download_minidump_stackwalk': True, 00:07:27 INFO - 'download_symbols': 'ondemand', 00:07:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:07:27 INFO - 'tooltool.py': '/tools/tooltool.py', 00:07:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:07:27 INFO - '/tools/misc-python/virtualenv.py')}, 00:07:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:07:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:07:27 INFO - 'installer_path': 'installer.exe', 00:07:27 INFO - 'log_level': 'info', 00:07:27 INFO - 'log_name': 'talos', 00:07:27 INFO - 'log_to_console': True, 00:07:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:07:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:07:27 INFO - 'opt_config_files': (), 00:07:27 INFO - 'pip_index': False, 00:07:27 INFO - 'sps_profile': False, 00:07:27 INFO - 'sps_profile_interval': 0, 00:07:27 INFO - 'suite': 'dromaeojs-e10s', 00:07:27 INFO - 'system_bits': '32', 00:07:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:07:27 INFO - 'title': 'talos-linux64-ix-001', 00:07:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:07:27 INFO - 'use_talos_json': True, 00:07:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:07:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:07:27 INFO - 'work_dir': 'build'} 00:07:27 INFO - ##### 00:07:27 INFO - ##### Running clobber step. 00:07:27 INFO - ##### 00:07:27 INFO - Running pre-action listener: _resource_record_pre_action 00:07:27 INFO - Running main action method: clobber 00:07:27 INFO - rmtree: /builds/slave/test/build 00:07:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:07:28 INFO - Running post-action listener: _resource_record_post_action 00:07:28 INFO - ##### 00:07:28 INFO - ##### Finished clobber step (success) 00:07:28 INFO - ##### 00:07:28 INFO - ##### 00:07:28 INFO - ##### Running read-buildbot-config step. 00:07:28 INFO - ##### 00:07:28 INFO - Running pre-action listener: _resource_record_pre_action 00:07:28 INFO - Running main action method: read_buildbot_config 00:07:28 INFO - Using buildbot properties: 00:07:28 INFO - { 00:07:28 INFO - "project": "", 00:07:28 INFO - "product": "firefox", 00:07:28 INFO - "script_repo_revision": "production", 00:07:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:07:28 INFO - "repository": "", 00:07:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 00:07:28 INFO - "buildid": "20160531173011", 00:07:28 INFO - "pgo_build": "True", 00:07:28 INFO - "basedir": "/builds/slave/test", 00:07:28 INFO - "buildnumber": 798, 00:07:28 INFO - "slavename": "talos-linux64-ix-001", 00:07:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:07:28 INFO - "platform": "ubuntu64_hw", 00:07:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:07:28 INFO - "branch": "fx-team", 00:07:28 INFO - "repo_path": "integration/fx-team", 00:07:28 INFO - "revision": "03d6c612af0ddbf22f4fbe12ad034831be38fab7", 00:07:28 INFO - "stage_platform": "linux64-pgo", 00:07:28 INFO - "builduid": "08eb6a699884491085b29eb1accfe308", 00:07:28 INFO - "slavebuilddir": "test" 00:07:28 INFO - } 00:07:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:07:28 INFO - Running post-action listener: _resource_record_post_action 00:07:28 INFO - ##### 00:07:28 INFO - ##### Finished read-buildbot-config step (success) 00:07:28 INFO - ##### 00:07:28 INFO - ##### 00:07:28 INFO - ##### Running download-and-extract step. 00:07:28 INFO - ##### 00:07:28 INFO - Running pre-action listener: _resource_record_pre_action 00:07:28 INFO - Running main action method: download_and_extract 00:07:28 INFO - mkdir: /builds/slave/test/build/tests 00:07:28 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')]} 00:07:28 INFO - https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:07:35 INFO - Downloaded 1361 bytes. 00:07:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:07:35 INFO - Using the following test package requirements: 00:07:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:07:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:07:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:07:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'jsshell-linux-x86_64.zip'], 00:07:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:07:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:07:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:07:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:07:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:07:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:07:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:07:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:35 INFO - https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:07:36 INFO - Downloaded 24413010 bytes. 00:07:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:07:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:07:37 INFO - Return code: 0 00:07:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:07:37 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')]} 00:07:37 INFO - https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:07:40 INFO - Downloaded 24413010 bytes. 00:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:07:41 INFO - Return code: 0 00: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')]} 00:07:41 INFO - https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:07:43 INFO - Downloaded 10834055 bytes. 00:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:07:44 INFO - Return code: 0 00: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')]} 00:07:44 INFO - https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:07:45 INFO - Downloaded 58965693 bytes. 00:07:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:07:45 INFO - mkdir: /builds/slave/test/properties 00:07:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:07:45 INFO - Writing to file /builds/slave/test/properties/build_url 00:07:45 INFO - Contents: 00:07:45 INFO - build_url:https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:07:46 INFO - Running post-action listener: _resource_record_post_action 00:07:46 INFO - Running post-action listener: set_extra_try_arguments 00:07:46 INFO - ##### 00:07:46 INFO - ##### Finished download-and-extract step (success) 00:07:46 INFO - ##### 00:07:46 INFO - ##### 00:07:46 INFO - ##### Running populate-webroot step. 00:07:46 INFO - ##### 00:07:46 INFO - Running pre-action listener: _resource_record_pre_action 00:07:46 INFO - Running main action method: populate_webroot 00:07:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:07:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:07:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:07:46 INFO - '--tppagecycles', 00:07:46 INFO - '7'], 00:07:46 INFO - 'tests': ['tsvgm']}}, 00:07:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:07:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:07:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:07:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:07:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:07:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:07:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['damp', 'tps']}, 00:07:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'tests': ['damp', 'tps']}, 00:07:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['dromaeo_dom']}, 00:07:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:07:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'other-e10s': {'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['a11yr', 00:07:46 INFO - 'ts_paint', 00:07:46 INFO - 'tpaint', 00:07:46 INFO - 'sessionrestore', 00:07:46 INFO - 'sessionrestore_no_auto_restore', 00:07:46 INFO - 'tabpaint']}, 00:07:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['tsvgx', 00:07:46 INFO - 'tsvgr_opacity', 00:07:46 INFO - 'tart', 00:07:46 INFO - 'tscrollx', 00:07:46 INFO - 'cart']}, 00:07:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:07:46 INFO - 'tsvgr_opacity', 00:07:46 INFO - 'tart', 00:07:46 INFO - 'tscrollx', 00:07:46 INFO - 'cart']}, 00:07:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'talos_options': ['--disable-e10s'], 00:07:46 INFO - 'tests': ['tp5o']}, 00:07:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'tests': ['tp5o']}, 00:07:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'talos_options': ['--disable-e10s', 00:07:46 INFO - '--xperf_path', 00:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:07:46 INFO - 'tests': ['tp5n']}, 00:07:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:07:46 INFO - 'talos_options': ['--xperf_path', 00:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:07:46 INFO - 'tests': ['tp5n']}}, 00:07:46 INFO - 'talos.zip': {'path': '', 00:07:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:07:46 INFO - Running post-action listener: _resource_record_post_action 00:07:46 INFO - ##### 00:07:46 INFO - ##### Finished populate-webroot step (success) 00:07:46 INFO - ##### 00:07:46 INFO - ##### 00:07:46 INFO - ##### Running create-virtualenv step. 00:07:46 INFO - ##### 00:07:46 INFO - Running pre-action listener: _resource_record_pre_action 00:07:46 INFO - Running main action method: create_virtualenv 00:07:46 INFO - Creating virtualenv /builds/slave/test/build/venv 00:07:46 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 00:07:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:07:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:07:46 INFO - Using real prefix '/usr' 00:07:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:07:46 INFO - Installing distribute.............................................................................................................................................................................................done. 00:07:48 INFO - Installing pip.................done. 00:07:48 INFO - Return code: 0 00:07:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00: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')]} 00:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00: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')]} 00:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:48 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:07:48 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 00:07:48 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 00:07:48 INFO - Using env: {'DISPLAY': ':0', 00:07:48 INFO - 'HOME': '/home/cltbld', 00:07:48 INFO - 'LANG': 'en_US.UTF-8', 00:07:48 INFO - 'LANGUAGE': 'en_US:en', 00:07:48 INFO - 'LOGNAME': 'cltbld', 00:07:48 INFO - 'MAIL': '/var/mail/cltbld', 00:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:48 INFO - 'MOZ_NO_REMOTE': '1', 00:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:48 INFO - 'NO_EM_RESTART': '1', 00:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:48 INFO - 'PWD': '/builds/slave/test', 00:07:48 INFO - 'SHELL': '/bin/bash', 00:07:48 INFO - 'SHLVL': '1', 00:07:48 INFO - 'TERM': 'linux', 00:07:48 INFO - 'TMOUT': '86400', 00:07:48 INFO - 'USER': 'cltbld', 00:07:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:48 INFO - '_': '/tools/buildbot/bin/python'} 00:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:49 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 00:07:49 INFO - Cleaning up... 00:07:49 INFO - Return code: 0 00:07:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:07:49 INFO - Using env: {'DISPLAY': ':0', 00:07:49 INFO - 'HOME': '/home/cltbld', 00:07:49 INFO - 'LANG': 'en_US.UTF-8', 00:07:49 INFO - 'LANGUAGE': 'en_US:en', 00:07:49 INFO - 'LOGNAME': 'cltbld', 00:07:49 INFO - 'MAIL': '/var/mail/cltbld', 00:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:49 INFO - 'MOZ_NO_REMOTE': '1', 00:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:49 INFO - 'NO_EM_RESTART': '1', 00:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:49 INFO - 'PWD': '/builds/slave/test', 00:07:49 INFO - 'SHELL': '/bin/bash', 00:07:49 INFO - 'SHLVL': '1', 00:07:49 INFO - 'TERM': 'linux', 00:07:49 INFO - 'TMOUT': '86400', 00:07:49 INFO - 'USER': 'cltbld', 00:07:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:49 INFO - '_': '/tools/buildbot/bin/python'} 00:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:49 INFO - Downloading/unpacking psutil>=3.1.1 00: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 00: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 00: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 00: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 00: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 00: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 00:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:07:51 INFO - Installing collected packages: psutil 00:07:51 INFO - Running setup.py install for psutil 00:07:51 INFO - building 'psutil._psutil_linux' extension 00:07:51 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 00:07:51 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 00:07:51 INFO - building 'psutil._psutil_posix' extension 00:07:51 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 00:07:51 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 00:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:07:51 INFO - Successfully installed psutil 00:07:51 INFO - Cleaning up... 00:07:51 INFO - Return code: 0 00:07:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00: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')]} 00:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00: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')]} 00:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:51 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:07:51 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 00:07:51 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 00:07:51 INFO - Using env: {'DISPLAY': ':0', 00:07:51 INFO - 'HOME': '/home/cltbld', 00:07:51 INFO - 'LANG': 'en_US.UTF-8', 00:07:51 INFO - 'LANGUAGE': 'en_US:en', 00:07:51 INFO - 'LOGNAME': 'cltbld', 00:07:51 INFO - 'MAIL': '/var/mail/cltbld', 00:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:51 INFO - 'MOZ_NO_REMOTE': '1', 00:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:51 INFO - 'NO_EM_RESTART': '1', 00:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:51 INFO - 'PWD': '/builds/slave/test', 00:07:51 INFO - 'SHELL': '/bin/bash', 00:07:51 INFO - 'SHLVL': '1', 00:07:51 INFO - 'TERM': 'linux', 00:07:51 INFO - 'TMOUT': '86400', 00:07:51 INFO - 'USER': 'cltbld', 00:07:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:51 INFO - '_': '/tools/buildbot/bin/python'} 00:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 00: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 00: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 00: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 00: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 00: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 00: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 00:07:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:07:53 INFO - Installing collected packages: mozsystemmonitor 00:07:53 INFO - Running setup.py install for mozsystemmonitor 00:07:54 INFO - Successfully installed mozsystemmonitor 00:07:54 INFO - Cleaning up... 00:07:54 INFO - Return code: 0 00:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:54 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:07:54 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 00:07:54 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 00:07:54 INFO - Using env: {'DISPLAY': ':0', 00:07:54 INFO - 'HOME': '/home/cltbld', 00:07:54 INFO - 'LANG': 'en_US.UTF-8', 00:07:54 INFO - 'LANGUAGE': 'en_US:en', 00:07:54 INFO - 'LOGNAME': 'cltbld', 00:07:54 INFO - 'MAIL': '/var/mail/cltbld', 00:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:54 INFO - 'MOZ_NO_REMOTE': '1', 00:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:54 INFO - 'NO_EM_RESTART': '1', 00:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:54 INFO - 'PWD': '/builds/slave/test', 00:07:54 INFO - 'SHELL': '/bin/bash', 00:07:54 INFO - 'SHLVL': '1', 00:07:54 INFO - 'TERM': 'linux', 00:07:54 INFO - 'TMOUT': '86400', 00:07:54 INFO - 'USER': 'cltbld', 00:07:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:54 INFO - '_': '/tools/buildbot/bin/python'} 00:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 00: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 00: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 00: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 00: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 00: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 00: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 00:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 00:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:07:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 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 00:07:56 INFO - Downloading docopt-0.6.1.tar.gz 00:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 00:07:56 INFO - Running setup.py install for blobuploader 00:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:07:57 INFO - Running setup.py install for requests 00:07:57 INFO - Running setup.py install for docopt 00:07:57 INFO - Successfully installed blobuploader requests docopt 00:07:57 INFO - Cleaning up... 00:07:57 INFO - Return code: 0 00:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:07:57 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:07:57 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 00:07:57 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 00:07:57 INFO - Using env: {'DISPLAY': ':0', 00:07:57 INFO - 'HOME': '/home/cltbld', 00:07:57 INFO - 'LANG': 'en_US.UTF-8', 00:07:57 INFO - 'LANGUAGE': 'en_US:en', 00:07:57 INFO - 'LOGNAME': 'cltbld', 00:07:57 INFO - 'MAIL': '/var/mail/cltbld', 00:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:07:57 INFO - 'MOZ_NO_REMOTE': '1', 00:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:07:57 INFO - 'NO_EM_RESTART': '1', 00:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:07:57 INFO - 'PWD': '/builds/slave/test', 00:07:57 INFO - 'SHELL': '/bin/bash', 00:07:57 INFO - 'SHLVL': '1', 00:07:57 INFO - 'TERM': 'linux', 00:07:57 INFO - 'TMOUT': '86400', 00:07:57 INFO - 'USER': 'cltbld', 00:07:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:07:57 INFO - '_': '/tools/buildbot/bin/python'} 00:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:07:57 INFO - Running setup.py (path:/tmp/pip-s0GrTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:07:57 INFO - Running setup.py (path:/tmp/pip-VSX_UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:07:57 INFO - Running setup.py (path:/tmp/pip-UB_OQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:07:58 INFO - Running setup.py (path:/tmp/pip-qgGOw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:07:58 INFO - Running setup.py (path:/tmp/pip-DkTvtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:07:58 INFO - Running setup.py (path:/tmp/pip-aSOt6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:07:58 INFO - Running setup.py (path:/tmp/pip-LP5Fl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:07:58 INFO - Running setup.py (path:/tmp/pip-QBmdEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:07:58 INFO - Running setup.py (path:/tmp/pip-5eliB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:07:58 INFO - Running setup.py (path:/tmp/pip-yNmleI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:07:58 INFO - Running setup.py (path:/tmp/pip-wdsp6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:07:58 INFO - Running setup.py (path:/tmp/pip-15axQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:07:58 INFO - Running setup.py (path:/tmp/pip-q7KZ2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:07:58 INFO - Running setup.py (path:/tmp/pip-lAbu3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:58 INFO - Running setup.py (path:/tmp/pip-yFpt9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:07:58 INFO - Running setup.py (path:/tmp/pip-tbDDiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:07:58 INFO - Running setup.py (path:/tmp/pip-F0pF9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:07:59 INFO - Running setup.py install for manifestparser 00:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Running setup.py install for mozcrash 00:07:59 INFO - Running setup.py install for mozdebug 00:07:59 INFO - Running setup.py install for mozdevice 00:07:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Running setup.py install for mozfile 00:07:59 INFO - Running setup.py install for mozhttpd 00:07:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Running setup.py install for mozinfo 00:07:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Running setup.py install for mozInstall 00:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:07:59 INFO - Running setup.py install for mozleak 00:07:59 INFO - Running setup.py install for mozlog 00:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Running setup.py install for moznetwork 00:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Running setup.py install for mozprocess 00:08:00 INFO - Running setup.py install for mozprofile 00:08:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Running setup.py install for mozrunner 00:08:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Running setup.py install for mozscreenshot 00:08:00 INFO - Running setup.py install for moztest 00:08:00 INFO - Running setup.py install for mozversion 00:08:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:08:00 INFO - Cleaning up... 00:08:00 INFO - Return code: 0 00:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:00 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')]} 00:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:00 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')]} 00:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:00 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:08:00 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 00:08:00 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 00:08:00 INFO - Using env: {'DISPLAY': ':0', 00:08:00 INFO - 'HOME': '/home/cltbld', 00:08:00 INFO - 'LANG': 'en_US.UTF-8', 00:08:00 INFO - 'LANGUAGE': 'en_US:en', 00:08:00 INFO - 'LOGNAME': 'cltbld', 00:08:00 INFO - 'MAIL': '/var/mail/cltbld', 00:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:00 INFO - 'MOZ_NO_REMOTE': '1', 00:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:00 INFO - 'NO_EM_RESTART': '1', 00:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:00 INFO - 'PWD': '/builds/slave/test', 00:08:00 INFO - 'SHELL': '/bin/bash', 00:08:00 INFO - 'SHLVL': '1', 00:08:00 INFO - 'TERM': 'linux', 00:08:00 INFO - 'TMOUT': '86400', 00:08:00 INFO - 'USER': 'cltbld', 00:08:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:00 INFO - '_': '/tools/buildbot/bin/python'} 00:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:08:01 INFO - Running setup.py (path:/tmp/pip-EL8BrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:08:01 INFO - Running setup.py (path:/tmp/pip-I0bbw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:08:01 INFO - Running setup.py (path:/tmp/pip-fQgw8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:08:01 INFO - Running setup.py (path:/tmp/pip-Miosv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:08:01 INFO - Running setup.py (path:/tmp/pip-tQ9jFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:08:01 INFO - Running setup.py (path:/tmp/pip-P2JhOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:08:01 INFO - Running setup.py (path:/tmp/pip-CoUz6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:08:01 INFO - Running setup.py (path:/tmp/pip-N9jzv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:08:01 INFO - Running setup.py (path:/tmp/pip-DxwKok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:08:01 INFO - Running setup.py (path:/tmp/pip-yN4eWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:08:01 INFO - Running setup.py (path:/tmp/pip-qdy7D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:08:01 INFO - Running setup.py (path:/tmp/pip-ToOkav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:08:01 INFO - Running setup.py (path:/tmp/pip-GiiUAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:08:01 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)) 00:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:08:01 INFO - Running setup.py (path:/tmp/pip-UuZ0yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:08:02 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)) 00:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:02 INFO - Running setup.py (path:/tmp/pip-R0SAJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:02 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)) 00:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:08:02 INFO - Running setup.py (path:/tmp/pip-1TsB0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:08:02 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)) 00:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:08:02 INFO - Running setup.py (path:/tmp/pip-SFogAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:08:02 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)) 00:08:02 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)) 00:08:02 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)) 00:08:02 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)) 00:08:02 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)) 00:08:02 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)) 00:08:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:08:02 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 00:08:02 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 00:08:02 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 00:08:02 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 00:08:02 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 00:08:02 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 00:08:04 INFO - Downloading blessings-1.6.tar.gz 00:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:08:04 INFO - Installing collected packages: blessings 00:08:04 INFO - Running setup.py install for blessings 00:08:04 INFO - Successfully installed blessings 00:08:04 INFO - Cleaning up... 00:08:04 INFO - Return code: 0 00:08:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:04 INFO - Reading from file tmpfile_stdout 00:08:04 INFO - Current package versions: 00:08:04 INFO - argparse == 1.2.1 00:08:04 INFO - blessings == 1.6 00:08:04 INFO - blobuploader == 1.2.4 00:08:04 INFO - docopt == 0.6.1 00:08:04 INFO - manifestparser == 1.1 00:08:04 INFO - mozInstall == 1.12 00:08:04 INFO - mozcrash == 0.17 00:08:04 INFO - mozdebug == 0.1 00:08:04 INFO - mozdevice == 0.48 00:08:04 INFO - mozfile == 1.2 00:08:04 INFO - mozhttpd == 0.7 00:08:04 INFO - mozinfo == 0.9 00:08:04 INFO - mozleak == 0.1 00:08:04 INFO - mozlog == 3.2 00:08:04 INFO - moznetwork == 0.27 00:08:04 INFO - mozprocess == 0.22 00:08:04 INFO - mozprofile == 0.28 00:08:04 INFO - mozrunner == 6.11 00:08:04 INFO - mozscreenshot == 0.1 00:08:04 INFO - mozsystemmonitor == 0.3 00:08:04 INFO - moztest == 0.7 00:08:04 INFO - mozversion == 1.4 00:08:04 INFO - psutil == 3.1.1 00:08:04 INFO - requests == 1.2.3 00:08:04 INFO - wsgiref == 0.1.2 00:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:04 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:08:04 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 00:08:04 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 00:08:04 INFO - Using env: {'DISPLAY': ':0', 00:08:04 INFO - 'HOME': '/home/cltbld', 00:08:04 INFO - 'LANG': 'en_US.UTF-8', 00:08:04 INFO - 'LANGUAGE': 'en_US:en', 00:08:04 INFO - 'LOGNAME': 'cltbld', 00:08:04 INFO - 'MAIL': '/var/mail/cltbld', 00:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:04 INFO - 'MOZ_NO_REMOTE': '1', 00:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:04 INFO - 'NO_EM_RESTART': '1', 00:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:04 INFO - 'PWD': '/builds/slave/test', 00:08:04 INFO - 'SHELL': '/bin/bash', 00:08:04 INFO - 'SHLVL': '1', 00:08:04 INFO - 'TERM': 'linux', 00:08:04 INFO - 'TMOUT': '86400', 00:08:04 INFO - 'USER': 'cltbld', 00:08:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:04 INFO - '_': '/tools/buildbot/bin/python'} 00:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 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)) 00:08:04 INFO - Cleaning up... 00:08:04 INFO - Return code: 0 00:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:08:04 INFO - Using env: {'DISPLAY': ':0', 00:08:04 INFO - 'HOME': '/home/cltbld', 00:08:04 INFO - 'LANG': 'en_US.UTF-8', 00:08:04 INFO - 'LANGUAGE': 'en_US:en', 00:08:04 INFO - 'LOGNAME': 'cltbld', 00:08:04 INFO - 'MAIL': '/var/mail/cltbld', 00:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:04 INFO - 'MOZ_NO_REMOTE': '1', 00:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:04 INFO - 'NO_EM_RESTART': '1', 00:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:04 INFO - 'PWD': '/builds/slave/test', 00:08:04 INFO - 'SHELL': '/bin/bash', 00:08:04 INFO - 'SHLVL': '1', 00:08:04 INFO - 'TERM': 'linux', 00:08:04 INFO - 'TMOUT': '86400', 00:08:04 INFO - 'USER': 'cltbld', 00:08:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:04 INFO - '_': '/tools/buildbot/bin/python'} 00:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:05 INFO - Downloading/unpacking jsonschema 00:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:08:06 INFO - Downloading/unpacking functools32 (from jsonschema) 00:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 00:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:08:07 INFO - warning: no files found matching '*.txt' 00:08:07 INFO - no previously-included directories found matching 'build' 00:08:07 INFO - no previously-included directories found matching 'dist' 00:08:07 INFO - no previously-included directories found matching '.git*' 00:08:07 INFO - Installing collected packages: jsonschema, functools32 00:08:07 INFO - Running setup.py install for functools32 00:08:07 INFO - warning: no files found matching '*.txt' 00:08:07 INFO - no previously-included directories found matching 'build' 00:08:07 INFO - no previously-included directories found matching 'dist' 00:08:07 INFO - no previously-included directories found matching '.git*' 00:08:07 INFO - Successfully installed jsonschema functools32 00:08:07 INFO - Cleaning up... 00:08:07 INFO - Return code: 0 00:08:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:08:07 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')]} 00:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:07 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')]} 00:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:07 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 0x7ff0b65a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', '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 00:08:07 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 00:08:07 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 00:08:07 INFO - Using env: {'DISPLAY': ':0', 00:08:07 INFO - 'HOME': '/home/cltbld', 00:08:07 INFO - 'LANG': 'en_US.UTF-8', 00:08:07 INFO - 'LANGUAGE': 'en_US:en', 00:08:07 INFO - 'LOGNAME': 'cltbld', 00:08:07 INFO - 'MAIL': '/var/mail/cltbld', 00:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:07 INFO - 'MOZ_NO_REMOTE': '1', 00:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:07 INFO - 'NO_EM_RESTART': '1', 00:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:07 INFO - 'PWD': '/builds/slave/test', 00:08:07 INFO - 'SHELL': '/bin/bash', 00:08:07 INFO - 'SHLVL': '1', 00:08:07 INFO - 'TERM': 'linux', 00:08:07 INFO - 'TMOUT': '86400', 00:08:07 INFO - 'USER': 'cltbld', 00:08:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:07 INFO - '_': '/tools/buildbot/bin/python'} 00:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:07 INFO - Downloading/unpacking flake8 00:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:08:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:08:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:08:10 INFO - no previously-included directories found matching 'docs/_build' 00:08:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:08:10 INFO - Running setup.py install for pep8 00:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:08:10 INFO - no previously-included directories found matching 'docs/_build' 00:08:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:08:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:08:10 INFO - Cleaning up... 00:08:10 INFO - Return code: 0 00:08:10 INFO - Running post-action listener: _resource_record_post_action 00:08:10 INFO - Running post-action listener: _start_resource_monitoring 00:08:10 INFO - Starting resource monitoring. 00:08:10 INFO - ##### 00:08:10 INFO - ##### Finished create-virtualenv step (success) 00:08:10 INFO - ##### 00:08:10 INFO - ##### 00:08:10 INFO - ##### Running install step. 00:08:10 INFO - ##### 00:08:10 INFO - Running pre-action listener: _resource_record_pre_action 00:08:10 INFO - Running main action method: install 00:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:10 INFO - Reading from file tmpfile_stdout 00:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 00:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:08:10 INFO - Reading from file tmpfile_stdout 00:08:10 INFO - Output received: 00:08:10 INFO - Usage: mozinstall [options] installer 00:08:10 INFO - Options: 00:08:10 INFO - -h, --help show this help message and exit 00:08:10 INFO - -d DEST, --destination=DEST 00:08:10 INFO - Directory to install application into. [default: 00:08:10 INFO - "/builds/slave/test"] 00:08:10 INFO - --app=APP Application being installed. [default: firefox] 00:08:10 INFO - mkdir: /builds/slave/test/build/application 00:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:08:27 INFO - Reading from file tmpfile_stdout 00:08:27 INFO - Output received: 00:08:27 INFO - /builds/slave/test/build/application/firefox/firefox 00:08:27 INFO - Running post-action listener: _resource_record_post_action 00:08:27 INFO - ##### 00:08:27 INFO - ##### Finished install step (success) 00:08:27 INFO - ##### 00:08:27 INFO - ##### 00:08:27 INFO - ##### Running run-tests step. 00:08:27 INFO - ##### 00:08:27 INFO - Running pre-action listener: _resource_record_pre_action 00:08:27 INFO - Running main action method: run_tests 00:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:08:27 INFO - Python 2.7.3 00:08:27 INFO - Return code: 0 00:08:27 INFO - grabbing minidump binary from tooltool 00:08: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')]} 00:08:27 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 0x115b9c0>, '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 0x115c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:08:27 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 00:08:27 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 00:08:27 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 00:08:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:08:27 INFO - Return code: 0 00:08:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:08:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:08:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:08:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:08:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:08:28 INFO - Return code: 0 00:08:28 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/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 00:08:28 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/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 00:08:28 INFO - Using env: {'DISPLAY': ':0', 00:08:28 INFO - 'HOME': '/home/cltbld', 00:08:28 INFO - 'LANG': 'en_US.UTF-8', 00:08:28 INFO - 'LANGUAGE': 'en_US:en', 00:08:28 INFO - 'LOGNAME': 'cltbld', 00:08:28 INFO - 'MAIL': '/var/mail/cltbld', 00:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:28 INFO - 'MOZ_NO_REMOTE': '1', 00:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:28 INFO - 'NO_EM_RESTART': '1', 00:08:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:28 INFO - 'PWD': '/builds/slave/test', 00:08:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:08:28 INFO - 'SHELL': '/bin/bash', 00:08:28 INFO - 'SHLVL': '1', 00:08:28 INFO - 'TERM': 'linux', 00:08:28 INFO - 'TMOUT': '86400', 00:08:28 INFO - 'USER': 'cltbld', 00:08:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843', 00:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:28 INFO - '_': '/tools/buildbot/bin/python'} 00:08:28 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/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 00:08:28 INFO - mozversion application_buildid: 20160531173011 00:08:28 INFO - mozversion application_changeset: 03d6c612af0ddbf22f4fbe12ad034831be38fab7 00:08:28 INFO - mozversion application_display_name: Nightly 00:08:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:08:28 INFO - mozversion application_name: Firefox 00:08:28 INFO - mozversion application_remotingname: firefox 00:08:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:08:28 INFO - mozversion application_vendor: Mozilla 00:08:28 INFO - mozversion application_version: 49.0a1 00:08:28 INFO - mozversion platform_buildid: 20160531173011 00:08:28 INFO - mozversion platform_changeset: 03d6c612af0ddbf22f4fbe12ad034831be38fab7 00:08:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:08:28 INFO - mozversion platform_version: 49.0a1 00:08:28 INFO - using testdate: 1464764908 00:08:28 INFO - actual date: 1464764908 00:08:28 INFO - starting webserver on 'localhost:33635' 00:08:28 INFO - SUITE-START | Running 2 tests 00:08:28 INFO - TEST-START | dromaeo_css 00:08:28 INFO - operating with platform_type : linux_ 00:08:28 INFO - Initialising browser for dromaeo_css test... 00:08:28 INFO - TEST-INFO | started process 2650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXm3JUP/profile http://localhost:33635/getInfo.html) 00:08:33 INFO - PROCESS | 2650 | __metrics Screen width/height:1600/1200 00:08:33 INFO - PROCESS | 2650 | colorDepth:24 00:08:33 INFO - PROCESS | 2650 | Browser inner width/height: 1024/697 00:08:33 INFO - PROCESS | 2650 | __metrics 00:08:33 ERROR - PROCESS | 2650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:08:34 INFO - TEST-INFO | 2650: exit 0 00:08:34 INFO - Browser initialized. 00:08:34 INFO - Running cycle 1/1 for dromaeo_css test... 00:08:34 INFO - TEST-INFO | started process 2865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXm3JUP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:08:46 INFO - PROCESS | 2865 | RSS: Main: 166678528 00:08:46 INFO - PROCESS | 2865 | 00:09:36 INFO - PROCESS | 2865 | 1464764976160 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] 00:11:43 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33635/tests/dromaeo/cssquery-ext.html) 00:11:44 INFO - PROCESS | 2865 | RSS: Main: 166776832 00:11:44 INFO - PROCESS | 2865 | 00:14:46 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-ext.html (next: http://localhost:33635/tests/dromaeo/cssquery-jquery.html) 00:14:47 INFO - PROCESS | 2865 | RSS: Main: 168542208 00:14:47 INFO - PROCESS | 2865 | 00:17:49 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33635/tests/dromaeo/cssquery-mootools.html) 00:17:49 INFO - PROCESS | 2865 | RSS: Main: 167276544 00:17:49 INFO - PROCESS | 2865 | 00:20:51 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33635/tests/dromaeo/cssquery-prototype.html) 00:20:52 INFO - PROCESS | 2865 | RSS: Main: 169275392 00:20:52 INFO - PROCESS | 2865 | 00:23:54 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33635/tests/dromaeo/cssquery-yui.html) 00:23:55 INFO - PROCESS | 2865 | RSS: Main: 167968768 00:23:55 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | Cycle 1(1): loaded http://localhost:33635/tests/dromaeo/cssquery-yui.html (next: http://localhost:33635/tests/dromaeo/cssquery-dojo.html) 00:26:57 INFO - PROCESS | 2865 | RSS: Main: 172834816 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | __start_tp_report 00:26:57 INFO - PROCESS | 2865 | _x_x_mozilla_page_load 00:26:57 INFO - PROCESS | 2865 | _x_x_mozilla_page_load_details 00:26:57 INFO - PROCESS | 2865 | |i|pagename|runs| 00:26:57 INFO - PROCESS | 2865 | |0;dojo.html;3114.8754049837994;3115.8597863096156;3128.452520808858;3138.4507711150573;3149.1497295730137;5330.200469929512;5372.623916325859;5382.838514844551;5430.131179011359;5437.32033495813;5371.838844834661;5442.292501974738;5463.9180412293745;5528.668279903209;5544.112941929292;4915.090708218991;4933.481984391641;4978.128827455199;5057.873553161182;5089.592832573385;4933.777979990891;5136.8715782105555;5185.24813901984;5201.401838788531;5210.713410762407;4915.582175515104;4971.850844474671;4987.6758010729545;5015.974920125413;5020.974895125538;4984.252362145671;4994.275830004665;4996.650234483587;4998.150314446517;5054.1660625996665;4986.152354099811;4989.126902792033;4992.500749925015;4999.475055119233;5032.370953630796;5294.232336311214;5354.9196762048605;5390.568754499631;5411.485908838694;5422.267993820823;5835.387284335168;5847.532197424196;5851.297844258716;5855.795047173328;5865.472107510302;5660.235868157828;5899.439553242435;5904;5907.438793314628;5917.585768996172;5361.839144825662;5398.568114550826;5410.3507579090365;5423.918641220424;5429.619926605139;5928.822135335947;5935.643861368246;5935.73289201987;5949.583529152917;5952.166696662471;5602.215689803431;5673.517750991212;5675.858103547362;5691.943080569141;5707.800226992118;5813.6221145625395;5880;5892.175095486636;5895.056790913519;5936.465718085393;5611.551075913999;5624.634398764068;5783.450572195635;5824.155497452845;5868.119782032729;5677;5678.3186017678145;5684.147377893349;5702.401247868997;5738.254026976467;4342.457192850894;4348.195583817004;4370.344448332712;4373.628241599499;4398.516163222043;3900.414937759302;3915.060385507458;3916.412538119305;3923.9019024524614;3957.960420395817;5582.134769110794;5632.070708333079;5662.235598194274;5662.858428539237;5734;5890;5901.645901245939;5945.554083443672;5958.463738263577;5958.76164953397;5494.2582751328855;5541.418151094158;5564.693941833238;5602.879424115194;5636.774529018793;5018.42288136869;5029.170186919117;5042.697438153723;5050;5052.8484145475695;6034.1853849730605;6059.697914169303;6070.544709146831;6086.878262434727;6117.480014198843;5708.657480551097;5851.268591426072;5882;5915.40845915405;5948.970255148696;6039.275286965592;6074.635521868702;6107.572469927062;6115.296740874678;6115.877682446415;5584.078627026495;5748.48263656273;5807.245058142415;5812.041013232769;5817.94182058174;5801.622894511843;5845.3570107289015;5885.47030767233;5894.970525147347;5920.970395147997;5759.280089988752;5769.913451298318;5789.45000224978;5790.478856902899;5791.449812267828;5522.6134170607675;5630.408807075198;5713.914291285717;5723.7424315905055;5744.569157313134;5469.288992430958;5536.695481748542;5581.888362232814;5596.18855265976;5691.743871525874;5649.265595472562;5727.627704199213;5729;5738.598298119092;5739.339975902658;5396.676199428047;5571.470710282679;5593.741408183127;5602.299712535933;5606.719664016864 00:26:57 INFO - PROCESS | 2865 | |1;ext.html;584.1150656755017;624.6907780648579;636.503527248746;639.2584601861838;648.2674577727169;42353.78823105884;43553.78223108888;43736.12527749447;43960.3405948911;46892.76553617236;44363.33454998169;45325.773371133095;45336.546634533646;45370.09259814802;45377.092458150815;8742.256908162797;8947.150020748019;8957.596908139149;8964.058773828752;8967.95516022419;8747.518886461243;8844.159804818564;8848.380613357067;8848.911510884873;8863.734087977371;8817.206451419372;8924.68763593271;8933.55332233389;8936.731898043068;8958.731238062835;8830.161134692195;8879.200871921526;8908.465492070432;8914.465132092095;8921.241694455979;8775.210231079169;8821.07378725231;8839.116088391109;8845;8871.955640221822;41650.37524437136;41968.16063678709;42126.578734212875;42131.57868421307;42170;3344.5652065231607;3472.6006509251506;3494.4234201356744;3621.149029977953;3859.749116307431;32103;32629;32740.508892366634;32743.18142046444;32968.3406331872;4269.829206831723;4275.783021453679;4337.154254920292;4341.4790225172865;4404.383386325917;304858;306833;307426;307876.46061769774;309152;57464.71267643635;57607.711961440764;57812.71093644505;57822.39799209046;58048.419515805144;34791.4781278281;35412.46881296731;35696.821515892254;37731.245375092345;60413.09380359298;17480.825191748176;17499.475015749547;17665.646687066444;17701.114944252735;17792;13459.05786594929;13459.05786594929;13560.932195339157;13566.864331356757;13634.659133521742;19597.020148992495;19653.60692786136;19784.20863165486;19799.802001979795;19844.107015184352;7338.4496162788;7401.555906645618;7606.695732170762;7672.80817979555;7706.537607743553;971.7424882406168;1089.833877750815;1102.97974373704;1120.4061847220985;1137.7496950670838;32448;32458.188545286557;32610.673893260762;32929.506057409155;35556.64443355585;1119.5801574409597;1156.150229581257;1175.0834349207632;1210.1952201785714;1235.1889390822873;16399.508014759576;16491.17544122813;16600.6679866402;16682.165891705365;16859.747103793452;509299;509443;509989;514239;515369;54106.729466352415;54285.72857135689;54862.45137548653;55110.44889551053;55303.44696552983;1211.8182272659171;1226.22134944311;1352.6579679229587;1353.4112660992303;1425.3229715884872;30430.543541846448;30651.693483065777;30856;31116.37767244597;32044;49858.75070624624;50253.497465024884;50260.49739502704;50583.74708126436;50777.74611126921;442238;444456;444465;445169;448497;24891.751082488943;26737.19788406351;26877.328066797705;26942.73057269402;27082.187534374;46125.76937115293;46536.301955471376;46612.7669361651;46832.53167468282;47112.29331560098;38709.80645096757;38916;39035.02412439712;39607.60392396039;39769.40345894756;37360.43959340666;38118.23763524769;38201;38928.22143557169;39388.409173861844;38707.6129238704;39128.413073804484;39202.43190272357;39774.60225397825;40030.19939601133;34374.484382733775;35222.8238858804;35252.47121293234;35319.646803531636;35970.46044309285;27539;27774.44451110926;27824.860875695493;27972.30069248285;27993.44013119767 00:26:57 INFO - PROCESS | 2865 | |2;jquery.html;379.5502329739259;383.54358313606804;389.6415297925908;390.4241244164857;396.51823035012455;14933.850661493381;17294.56763580911;17635.29458821649;19191.71212431813;19308.61382772344;18381.816181838178;18382.90808545959;18509.444716658523;18690.15894284757;18697.532561685966;5089.3129427527365;5549.972250138754;5664.688442135681;5697.116946873241;5699.800506982257;5607;5610.186522954169;5627.971860140714;5632.662040277596;5633.324001119871;5424.566034717213;5557;5617.887642247153;5646.435356464342;5656.91514627281;5454.1546060360315;5609.691466969315;5620.859478513049;5651.689157096358;5658.0381335172915;5046.6719663221775;5048.368953880765;5063.772130254148;5068.873278168038;5073.416557095908;21357.786422135734;21477.785222147733;21882.23412180566;22484.10063597454;22536.43658908524;2195.8243340532717;2203.7355517338024;2305.827062970284;2339.520398318358;2368.218487898989;13801.240931748749;13874.306284685725;14219.289035548285;14241.572752817432;14331.498397556035;1935.9806401935941;1998.7901270366692;2044.2947183221765;2056.4139220322136;2056.5269987902716;73929;74693.99999999946;75992.62003690001;76485.23514764837;77472.61263693702;9712.514374281258;9731.756706082404;9993.201223779644;10036.096751292418;10207.948960255151;11055.22613417053;11770.764584708259;13718.725625487434;13796.241206733726;13804.447822087004;5527.44725527444;5691.4877661010705;6386.8722625547225;7598.734044308423;7697.191794861571;7875.803104922423;7982.840343193104;8114.918850811417;8156.632951517196;8180.263776260165;3409.232922592397;3529.0471572675233;3578;3880.3403421418425;4015.558288588253;1946.5036415714185;1968.4685135013754;1973.9013049347475;1978.5152637603878;1985.4837742186846;1023.1150055202196;1029.5572903651503;1068.433730123036;1107.6953837694537;1146.6344247998004;17833.910830446024;18038.729419058724;18148.183331750104;18152.818471815113;18176.207989728035;944.4852555357347;950.6672664567346;983.4836710726926;1007.4106647611083;1036.5594622285648;8739.868901966476;10302.484875756332;10335.483225838678;10337.0696637303;10354.585816567253;510906;511969;520621;529066;538071;89733;92401;92436;93642;94338;1012.71643939697;1023.2070145637042;1023.4166525080633;1046.9110125639406;1050.4327663062013;15975.680486389974;16211.35154593803;16276.67446651084;16381.344746210018;16500.42248521344;30827.95419572737;40839.7958010208;40963.1807363857;41003;41140.177196456505;55564.72217638886;55930.720346398004;57021;57699.71150144222;57967.71016144892;6613.43785778195;6951.895721564079;8180.713675021346;8293.792655183428;8318.584070796556;11435.656930292105;12502.124851260325;12567.24596524175;12748.872511274769;12816.010535347332;11071.1696622752;11134.55461781552;11327.263727857662;11388.37363944991;11398.373089480157;10964.06805421548;11077;11154.944225278821;11156.386398747822;11208;11036.944815275872;11051;11318.32090074598;11398.316101033965;11460.312381257152;7174.605396703231;7229.060222171084;7239.914012897897;7244.203137654748;7894.921050789419;8003.799905002422;10232.334898231591;11373.260738052;11541.249818761753;11567.76864462723 00:26:57 INFO - PROCESS | 2865 | |3;mootools.html;1484.7030593881223;1497.191516581046;1696.4995326378726;1815.7367181758655;1850.6668799616064;7678.846423071535;8641.870371944418;8667.523286219255;9250.953745231272;9253.537323133842;8681.04508504064;8900.1544853239;8957.104289571056;8971;8971.685990990316;2327.464683122883;2346.343023953296;2370.8577485350934;2371.4664200554907;2372.7508611595795;2308.3190458814606;2334.1830359374253;2361.0909799727056;2368.798652114572;2377.2986968844148;2307.469282065126;2321.58211521926;2339.9532009359805;2373.193114341124;2375.1449478187837;2265.2411442166813;2290.541891621682;2295.850769699964;2304.158981971585;2329.6039673255586;2260.400993736661;2263.7283525976823;2266.7506574276817;2278.931632051041;2285.611446054175;8926.419782714103;9004.964429090673;9009.459432434074;9011.143941325563;9016.413933094393;5342.2253773202665;5478.287822583039;5482.396936337;5485.341758988907;5489.58828087895;3054.404391143728;3153.369326134782;3255.6744325567493;3258.885938992124;3259.1526203187104;960.4333443268436;977.1010670183448;978.8189185000798;1030.9123724483352;1041.5209003858233;12652.557160499431;12703.491860325576;12711.809322860072;12722.681932951658;12743.745125097446;4615.861524154281;4772.189040646986;4852.660313778002;4852.975735121372;4853.247746599282;10520.947395262974;10598.947005264925;10618.150547956146;10632.46837658114;10663.146948244123;5337.866553336197;5359.5712343012465;5407.567394608422;5414.187871819258;5480.3971563128025;4433.224185767478;4838.879028024327;4922.433920099163;4932.0135972804865;4975.303457515951;3984.9800750996637;3985.8405663773706;4073.877783666495;4085.3667681509414;4132.607402296777;1261.7224210673637;1269.8666640002666;1272.3765354975994;1277.552856500236;1296.027979015738;983.4640121133999;996.6362277768707;1002.2282842211456;1002.2983911262;1007.9647212347533;5900.675462849585;5975.37258587842;6033.215681961317;6066.090086487062;6132.264128304632;447.9596836284685;455.6605329029894;459.38213103375904;460.1165761737472;461.25967821646447;3956.4460975462885;4117.1765646870745;4122.093139509303;4136;4142.233686767958;10674.146068314516;11154.330740155616;11160.274582152297;11192.888071119347;11205.66383008511;10827.945860270805;10937.015668589866;11011.174161937886;11062.336259824437;11132.220744547803;8066.596670166468;8554.828903421896;8607.741767746978;8615.569221538897;8619.094995025558;6148.1699970503405;6281.7173227203975;6283.37166283368;6389.105525226379;6401.455876250571;10233.48832558384;10421.895781042092;10438.53026613789;10512.684619461428;10552.894471055191;10465.47672616351;10497.842532362174;10672.946635266773;10752;10777.676669699922;7310.488265821342;7599.772006839804;7867.9606601966625;8049;8093.231143041402;8612.526311052952;8656.264217541328;8674.045854956075;8675.175858293453;8743.650253990023;7738.303552680286;7798.922010779819;7876.369890408639;7985.680572777256;8015.358771298399;7484.887726684213;7674.8081297968;7714.305712485903;7762.301392874669;7769.067711874612;6998.685059172248;7036.8592628146125;7038.436925045881;7058.682359293742;7080.575165490087;5300.761465733974;5391.16436952273;5434.2392065110125;5454.318210223722;5457.263269458573;5223.712695801767;5403.891922161613;5453.890922181614;5457.590680698884;5602.1036634138345 00:26:57 INFO - PROCESS | 2865 | |4;prototype.html;286.61307235232425;303.7463717795641;313.3669986627015;313.778785955901;315.86575705325237;5327.334083239595;5400.864978375543;5559.9444005559935;5632.042552766029;5666.660000399974;5551.72241387931;5584.888302233953;5594.86012849679;5596.496315331619;5602.523785478229;4261.50992635847;4268.59448352406;4295.334223195394;4316.7194132381455;4341.1317736452675;4106.630403263705;4302.935455968163;4303.934111626421;4320.07118469529;4332.9566704332865;4187.685923555746;4229.555896630855;4238.639715624176;4264.104538046999;4272.87181384559;4222.936655950163;4229.133027729339;4263.701540892123;4274.786260686984;4287.978560107195;3563.6614521620663;3671.3575124353133;3698.149425632093;3698.408254679265;3712.795796231206;5390.595705322077;5400.891982160335;5422.240886275925;5443.836684899459;5498.752556134944;4803.831865884677;4822.421309442854;4854.466008739036;4878.219484882402;4902.215645496739;5637.661740295595;5813.360530341659;5822.796202132905;5861;5861.5603829712945;4057.2696914555368;4070.247004304213;4078.490188726409;4092.4270602115726;4119.711620186558;6144.293406258293;6152.261728592597;6166.260048794174;6170;6178.598391104609;3967.8412863485137;4173.873054275328;4190.141021090669;4208.894777630522;4220.311875249863;4169.332906734908;4199.404226393951;4256.297710877732;4266.338717498793;4273.273543497613;4851.248056551241;4882.536159064884;4883.218685010382;4921.351347298623;4930.309756634074;5288.202011316094;5831.300243970751;5835;5895.67573783446;5975.25309336333;1467.889908256885;1478.4455829064102;1484.3246322923044;1487.133647272666;1488.3674438363653;898.9706785730302;934.514052692596;938.1603464898877;947.1806887042659;953.2755106119399;4982.950170498321;5003.949960500421;5010.918285254542;5031.84904452867;5037.370328708911;5233.816816411408;5349.1976203569;5359.839204823861;5402.540784033401;5440.91838622421;5081.212412076134;5115.539601435814;5145.511176438233;5355.839324820184;5822.650640961556;3200.7919485233383;3212.1969507623094;3264.477683570665;3265.2000259935994;3272.3128143089743;6047.274327080779;6276.497880169575;6276.686165691697;6315.179026726496;6315.842103947346;6117.602355846945;6128.233970753656;6132.356102609251;6154.415330543591;6172.321044685081;6261;6264.937350626436;6290.00584628764;6310.116583678288;6319.399657032574;5789.2763404574425;6032.526664067711;6055.697215139137;6071.574989750675;6110.450059494667;5968.641881487125;5978.551608629283;5984.760609575568;6004.699765011645;6024.186734790747;5947.434993675594;6248.968755156195;6253.843653908689;6276.717547710273;6294.181756371826;4114.691398145092;4127.318992366226;4142.751434913915;4172.457580514514;4177.516981471534;5785.450382213683;5879.618754404473;6056.333803281547;6067.605605635797;6071.453569178795;5904.663864916309;5933.821985340447;5940.851478713067;5961.688428545713;5968.194293770285;5844.327902291291;5907.232059832194;5944.762209511744;5948.583599148018;5968.283805943314;5558.194061860927;5737.454941780524;5759.0209664356325;5766.509846663081;5846.327672317738;5952.255968003999;5954.404559544011;5963.522918166623;6000.87998240024;6027.758889644365;5707.800226992035;5744.827655170351;5770.855728606651;5860.589758716849;5888.586739182651 00:26:57 INFO - PROCESS | 2865 | |5;yui.html;816.6080281464897;836.1972506393862;838.4172999765162;852.2585350744853;853.6798700487317;15219.543413697578;15719.449819256328;15822.05067695939;15847.286872090755;15853;11406.657800266004;14545;14617.561473155796;14645.121292722444;14661.486847960323;804.7505273365247;821.9219174178444;822.6668199379261;829.8049958259834;830.0910502999236;816.7304789419477;818.7543736878943;819.4304958054155;822.383212590557;823.4071468542639;865.5672163918041;866.3199388480044;871.777696687347;875.5578432891381;875.5797217335651;853.6158728572105;855.8117214212863;857.9270761985239;858.1675774498726;864.4942708515526;629.0972454527767;630.4641055103126;631.6115588912786;633.6926590603554;634.5494698763883;14484.927575362055;14548.636284092983;14552.563423097325;14571.489997850025;14580.198089105095;14159.575212743634;14229;14260;14273.71452570953;14328.426862925471;11584.768304633944;11709.648710538613;11740.236884602558;11770.940615344574;12084.879151208552;3825.5600605930395;3866.9613303867163;3938.330483817758;3943.7633741975574;4031.697622678311;53046.46953530454;54598.454015460135;60050.699746500984;60072.098918516254;60507.394926051056;10468.947655261827;10687.51906164209;10944.23390362683;11001.724956876142;11172.923052426297;19668.508287292647;19813;19903.303384381477;19913.800861991484;20039.398818035483;7956.085050219183;8077;8240.62917168729;8300.169983001651;8301.709440169565;4786.401699787527;4814.325994360793;4859.07677541266;4945.2087665973995;4974.626902982291;3375.9493607595905;3412.061683037135;3443.7589368743947;3483.076984599083;3494.143934735955;620.218524658933;637.6588525139028;638.0365647871747;640.1198352265635;655.8195248552586;612.3233826621608;644.2011905237472;704.2710794327846;712.7362875735907;751.3463286940397;8703.869441958375;8738.781530461662;8770.473771573726;8805.779855503535;9016.18854303116;698.7030512032366;709.6345382128105;714.1109318897901;718.8202949262684;735.3308489274841;4047.170330082326;4124.628783409507;4144.70987030911;4231.894202644959;4292.18448494785;60812;61091.69454152701;62248.37751622516;62555.68722156451;63345.366546334866;62921.370786291554;62952.37047629465;63343.36656633467;64399;64738;52371.73814130905;53847;53870.191947120824;59456.405435945955;59570.80858382808;8821.073787252502;9013.18881300686;9057.637694492147;9132.908670913206;9141.720159177854;38754.6124538751;38985;39397.21205575815;40128.398074029494;40418;51197.744011279705;52227.73886130545;52856.47143528515;53041;54429.72785136049;12444.191127576678;12500.93749531283;12515.37423128858;12572.931873782334;12795.80806287925;13834.912955545558;13836.100653457494;14130.92934535362;14139.222342770834;14360.784588230976;13074.150180238254;13493.730125397633;13500.122492037986;13549.458021679022;13885.166889986633;12997.480100795863;13098.672533186747;13318.40067196998;13653.795193071914;13684.931575342458;12726.363681815687;12921.28932908699;13571.050026498051;13757.38091785852;13766;10461.843072354073;10744.194185435967;10754.89245107539;11082.390468523987;11103.333799972028;11307.265027773168;11349.14881383883;11374.829377559177;11550.48022838991;11816.350100744541 00:26:57 INFO - PROCESS | 2865 | __end_tp_report 00:26:57 INFO - PROCESS | 2865 | __start_cc_report 00:26:57 INFO - PROCESS | 2865 | _x_x_mozilla_cycle_collect,330 00:26:57 INFO - PROCESS | 2865 | __end_cc_report 00:26:57 INFO - PROCESS | 2865 | __startTimestamp1464766017734__endTimestamp 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | ------- Summary: start ------- 00:26:57 INFO - PROCESS | 2865 | Number of tests: 6 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#0] dojo.html Cycles:165 Average:5422.77 Median:5611.55 stddev:624.62 (11.1%) stddev-sans-first:599.72 00:26:57 INFO - PROCESS | 2865 | Values: 3114.9 3115.9 3128.5 3138.5 3149.1 5330.2 5372.6 5382.8 5430.1 5437.3 5371.8 5442.3 5463.9 5528.7 5544.1 4915.1 4933.5 4978.1 5057.9 5089.6 4933.8 5136.9 5185.2 5201.4 5210.7 4915.6 4971.9 4987.7 5016.0 5021.0 4984.3 4994.3 4996.7 4998.2 5054.2 4986.2 4989.1 4992.5 4999.5 5032.4 5294.2 5354.9 5390.6 5411.5 5422.3 5835.4 5847.5 5851.3 5855.8 5865.5 5660.2 5899.4 5904.0 5907.4 5917.6 5361.8 5398.6 5410.4 5423.9 5429.6 5928.8 5935.6 5935.7 5949.6 5952.2 5602.2 5673.5 5675.9 5691.9 5707.8 5813.6 5880.0 5892.2 5895.1 5936.5 5611.6 5624.6 5783.5 5824.2 5868.1 5677.0 5678.3 5684.1 5702.4 5738.3 4342.5 4348.2 4370.3 4373.6 4398.5 3900.4 3915.1 3916.4 3923.9 3958.0 5582.1 5632.1 5662.2 5662.9 5734.0 5890.0 5901.6 5945.6 5958.5 5958.8 5494.3 5541.4 5564.7 5602.9 5636.8 5018.4 5029.2 5042.7 5050.0 5052.8 6034.2 6059.7 6070.5 6086.9 6117.5 5708.7 5851.3 5882.0 5915.4 5949.0 6039.3 6074.6 6107.6 6115.3 6115.9 5584.1 5748.5 5807.2 5812.0 5817.9 5801.6 5845.4 5885.5 5895.0 5921.0 5759.3 5769.9 5789.5 5790.5 5791.4 5522.6 5630.4 5713.9 5723.7 5744.6 5469.3 5536.7 5581.9 5596.2 5691.7 5649.3 5727.6 5729.0 5738.6 5739.3 5396.7 5571.5 5593.7 5602.3 5606.7 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#1] ext.html Cycles:180 Average:57786.65 Median:39772.00 stddev:113919.48 (286.4%) stddev-sans-first:114158.09 00:26:57 INFO - PROCESS | 2865 | Values: 584.1 624.7 636.5 639.3 648.3 42353.8 43553.8 43736.1 43960.3 46892.8 44363.3 45325.8 45336.5 45370.1 45377.1 8742.3 8947.2 8957.6 8964.1 8968.0 8747.5 8844.2 8848.4 8848.9 8863.7 8817.2 8924.7 8933.6 8936.7 8958.7 8830.2 8879.2 8908.5 8914.5 8921.2 8775.2 8821.1 8839.1 8845.0 8872.0 41650.4 41968.2 42126.6 42131.6 42170.0 3344.6 3472.6 3494.4 3621.1 3859.7 32103.0 32629.0 32740.5 32743.2 32968.3 4269.8 4275.8 4337.2 4341.5 4404.4 304858.0 306833.0 307426.0 307876.5 309152.0 57464.7 57607.7 57812.7 57822.4 58048.4 34791.5 35412.5 35696.8 37731.2 60413.1 17480.8 17499.5 17665.6 17701.1 17792.0 13459.1 13459.1 13560.9 13566.9 13634.7 19597.0 19653.6 19784.2 19799.8 19844.1 7338.4 7401.6 7606.7 7672.8 7706.5 971.7 1089.8 1103.0 1120.4 1137.7 32448.0 32458.2 32610.7 32929.5 35556.6 1119.6 1156.2 1175.1 1210.2 1235.2 16399.5 16491.2 16600.7 16682.2 16859.7 509299.0 509443.0 509989.0 514239.0 515369.0 54106.7 54285.7 54862.5 55110.4 55303.4 1211.8 1226.2 1352.7 1353.4 1425.3 30430.5 30651.7 30856.0 31116.4 32044.0 49858.8 50253.5 50260.5 50583.7 50777.7 442238.0 444456.0 444465.0 445169.0 448497.0 24891.8 26737.2 26877.3 26942.7 27082.2 46125.8 46536.3 46612.8 46832.5 47112.3 38709.8 38916.0 39035.0 39607.6 39769.4 37360.4 38118.2 38201.0 38928.2 39388.4 38707.6 39128.4 39202.4 39774.6 40030.2 34374.5 35222.8 35252.5 35319.6 35970.5 27539.0 27774.4 27824.9 27972.3 27993.4 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#2] jquery.html Cycles:180 Average:29238.89 Median:2353.87 stddev:85930.60 (3650.6%) stddev-sans-first:86144.34 00:26:57 INFO - PROCESS | 2865 | Values: 379.6 383.5 389.6 390.4 396.5 14933.9 17294.6 17635.3 19191.7 19308.6 18381.8 18382.9 18509.4 18690.2 18697.5 5089.3 5550.0 5664.7 5697.1 5699.8 5607.0 5610.2 5628.0 5632.7 5633.3 5424.6 5557.0 5617.9 5646.4 5656.9 5454.2 5609.7 5620.9 5651.7 5658.0 5046.7 5048.4 5063.8 5068.9 5073.4 21357.8 21477.8 21882.2 22484.1 22536.4 2195.8 2203.7 2305.8 2339.5 2368.2 13801.2 13874.3 14219.3 14241.6 14331.5 1936.0 1998.8 2044.3 2056.4 2056.5 73929.0 74694.0 75992.6 76485.2 77472.6 9712.5 9731.8 9993.2 10036.1 10207.9 11055.2 11770.8 13718.7 13796.2 13804.4 5527.4 5691.5 6386.9 7598.7 7697.2 7875.8 7982.8 8114.9 8156.6 8180.3 3409.2 3529.0 3578.0 3880.3 4015.6 1946.5 1968.5 1973.9 1978.5 1985.5 1023.1 1029.6 1068.4 1107.7 1146.6 17833.9 18038.7 18148.2 18152.8 18176.2 944.5 950.7 983.5 1007.4 1036.6 8739.9 10302.5 10335.5 10337.1 10354.6 510906.0 511969.0 520621.0 529066.0 538071.0 89733.0 92401.0 92436.0 93642.0 94338.0 1012.7 1023.2 1023.4 1046.9 1050.4 15975.7 16211.4 16276.7 16381.3 16500.4 30828.0 40839.8 40963.2 41003.0 41140.2 55564.7 55930.7 57021.0 57699.7 57967.7 6613.4 6951.9 8180.7 8293.8 8318.6 11435.7 12502.1 12567.2 12748.9 12816.0 11071.2 11134.6 11327.3 11388.4 11398.4 10964.1 11077.0 11154.9 11156.4 11208.0 11036.9 11051.0 11318.3 11398.3 11460.3 7174.6 7229.1 7239.9 7244.2 7894.9 8003.8 10232.3 11373.3 11541.2 11567.8 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#3] mootools.html Cycles:180 Average:5904.96 Median:2538.56 stddev:3408.97 (134.3%) stddev-sans-first:3402.35 00:26:57 INFO - PROCESS | 2865 | Values: 1484.7 1497.2 1696.5 1815.7 1850.7 7678.8 8641.9 8667.5 9251.0 9253.5 8681.0 8900.2 8957.1 8971.0 8971.7 2327.5 2346.3 2370.9 2371.5 2372.8 2308.3 2334.2 2361.1 2368.8 2377.3 2307.5 2321.6 2340.0 2373.2 2375.1 2265.2 2290.5 2295.9 2304.2 2329.6 2260.4 2263.7 2266.8 2278.9 2285.6 8926.4 9005.0 9009.5 9011.1 9016.4 5342.2 5478.3 5482.4 5485.3 5489.6 3054.4 3153.4 3255.7 3258.9 3259.2 960.4 977.1 978.8 1030.9 1041.5 12652.6 12703.5 12711.8 12722.7 12743.7 4615.9 4772.2 4852.7 4853.0 4853.2 10520.9 10598.9 10618.2 10632.5 10663.1 5337.9 5359.6 5407.6 5414.2 5480.4 4433.2 4838.9 4922.4 4932.0 4975.3 3985.0 3985.8 4073.9 4085.4 4132.6 1261.7 1269.9 1272.4 1277.6 1296.0 983.5 996.6 1002.2 1002.3 1008.0 5900.7 5975.4 6033.2 6066.1 6132.3 448.0 455.7 459.4 460.1 461.3 3956.4 4117.2 4122.1 4136.0 4142.2 10674.1 11154.3 11160.3 11192.9 11205.7 10827.9 10937.0 11011.2 11062.3 11132.2 8066.6 8554.8 8607.7 8615.6 8619.1 6148.2 6281.7 6283.4 6389.1 6401.5 10233.5 10421.9 10438.5 10512.7 10552.9 10465.5 10497.8 10672.9 10752.0 10777.7 7310.5 7599.8 7868.0 8049.0 8093.2 8612.5 8656.3 8674.0 8675.2 8743.7 7738.3 7798.9 7876.4 7985.7 8015.4 7484.9 7674.8 7714.3 7762.3 7769.1 6998.7 7036.9 7038.4 7058.7 7080.6 5300.8 5391.2 5434.2 5454.3 5457.3 5223.7 5403.9 5453.9 5457.6 5602.1 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#4] prototype.html Cycles:180 Average:4867.37 Median:5471.29 stddev:1465.39 (26.8%) stddev-sans-first:1428.60 00:26:57 INFO - PROCESS | 2865 | Values: 286.6 303.7 313.4 313.8 315.9 5327.3 5400.9 5559.9 5632.0 5666.7 5551.7 5584.9 5594.9 5596.5 5602.5 4261.5 4268.6 4295.3 4316.7 4341.1 4106.6 4302.9 4303.9 4320.1 4333.0 4187.7 4229.6 4238.6 4264.1 4272.9 4222.9 4229.1 4263.7 4274.8 4288.0 3563.7 3671.4 3698.1 3698.4 3712.8 5390.6 5400.9 5422.2 5443.8 5498.8 4803.8 4822.4 4854.5 4878.2 4902.2 5637.7 5813.4 5822.8 5861.0 5861.6 4057.3 4070.2 4078.5 4092.4 4119.7 6144.3 6152.3 6166.3 6170.0 6178.6 3967.8 4173.9 4190.1 4208.9 4220.3 4169.3 4199.4 4256.3 4266.3 4273.3 4851.2 4882.5 4883.2 4921.4 4930.3 5288.2 5831.3 5835.0 5895.7 5975.3 1467.9 1478.4 1484.3 1487.1 1488.4 899.0 934.5 938.2 947.2 953.3 4983.0 5003.9 5010.9 5031.8 5037.4 5233.8 5349.2 5359.8 5402.5 5440.9 5081.2 5115.5 5145.5 5355.8 5822.7 3200.8 3212.2 3264.5 3265.2 3272.3 6047.3 6276.5 6276.7 6315.2 6315.8 6117.6 6128.2 6132.4 6154.4 6172.3 6261.0 6264.9 6290.0 6310.1 6319.4 5789.3 6032.5 6055.7 6071.6 6110.5 5968.6 5978.6 5984.8 6004.7 6024.2 5947.4 6249.0 6253.8 6276.7 6294.2 4114.7 4127.3 4142.8 4172.5 4177.5 5785.5 5879.6 6056.3 6067.6 6071.5 5904.7 5933.8 5940.9 5961.7 5968.2 5844.3 5907.2 5944.8 5948.6 5968.3 5558.2 5737.5 5759.0 5766.5 5846.3 5952.3 5954.4 5963.5 6000.9 6027.8 5707.8 5744.8 5770.9 5860.6 5888.6 00:26:57 INFO - PROCESS | 2865 | 00:26:57 INFO - PROCESS | 2865 | [#5] yui.html Cycles:180 Average:15856.97 Median:4800.36 stddev:18767.01 (390.9%) stddev-sans-first:18785.66 00:26:57 INFO - PROCESS | 2865 | Values: 816.6 836.2 838.4 852.3 853.7 15219.5 15719.4 15822.1 15847.3 15853.0 11406.7 14545.0 14617.6 14645.1 14661.5 804.8 821.9 822.7 829.8 830.1 816.7 818.8 819.4 822.4 823.4 865.6 866.3 871.8 875.6 875.6 853.6 855.8 857.9 858.2 864.5 629.1 630.5 631.6 633.7 634.5 14484.9 14548.6 14552.6 14571.5 14580.2 14159.6 14229.0 14260.0 14273.7 14328.4 11584.8 11709.6 11740.2 11770.9 12084.9 3825.6 3867.0 3938.3 3943.8 4031.7 53046.5 54598.5 60050.7 60072.1 60507.4 10468.9 10687.5 10944.2 11001.7 11172.9 19668.5 19813.0 19903.3 19913.8 20039.4 7956.1 8077.0 8240.6 8300.2 8301.7 4786.4 4814.3 4859.1 4945.2 4974.6 3375.9 3412.1 3443.8 3483.1 3494.1 620.2 637.7 638.0 640.1 655.8 612.3 644.2 704.3 712.7 751.3 8703.9 8738.8 8770.5 8805.8 9016.2 698.7 709.6 714.1 718.8 735.3 4047.2 4124.6 4144.7 4231.9 4292.2 60812.0 61091.7 62248.4 62555.7 63345.4 62921.4 62952.4 63343.4 64399.0 64738.0 52371.7 53847.0 53870.2 59456.4 59570.8 8821.1 9013.2 9057.6 9132.9 9141.7 38754.6 38985.0 39397.2 40128.4 40418.0 51197.7 52227.7 52856.5 53041.0 54429.7 12444.2 12500.9 12515.4 12572.9 12795.8 13834.9 13836.1 14130.9 14139.2 14360.8 13074.2 13493.7 13500.1 13549.5 13885.2 12997.5 13098.7 13318.4 13653.8 13684.9 12726.4 12921.3 13571.1 13757.4 13766.0 10461.8 10744.2 10754.9 11082.4 11103.3 11307.3 11349.1 11374.8 11550.5 11816.4 00:26:57 INFO - PROCESS | 2865 | -------- Summary: end -------- 00:26:57 INFO - PROCESS | 2865 | 00:26:58 INFO - TEST-INFO | 2865: exit 0 00:26:58 INFO - TEST-OK | dromaeo_css | took 1109660ms 00:26:58 INFO - TEST-START | kraken 00:26:58 INFO - operating with platform_type : linux_ 00:26:58 INFO - Initialising browser for kraken test... 00:26:58 INFO - TEST-INFO | started process 3117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uM2s_/profile http://localhost:33635/getInfo.html) 00:27:02 INFO - PROCESS | 3117 | __metrics Screen width/height:1600/1200 00:27:02 INFO - PROCESS | 3117 | colorDepth:24 00:27:02 INFO - PROCESS | 3117 | Browser inner width/height: 1024/697 00:27:02 INFO - PROCESS | 3117 | __metrics 00:27:03 ERROR - PROCESS | 3117 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:27:04 INFO - TEST-INFO | 3117: exit 0 00:27:04 INFO - Browser initialized. 00:27:04 INFO - Running cycle 1/1 for kraken test... 00:27:04 INFO - TEST-INFO | started process 3236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uM2s_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:16 INFO - PROCESS | 3236 | RSS: Main: 166862848 00:27:16 INFO - PROCESS | 3236 | 00:27:18 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33635/tests/kraken/driver.html?testName=audio-beat-detection) 00:27:19 INFO - PROCESS | 3236 | RSS: Main: 171708416 00:27:19 INFO - PROCESS | 3236 | 00:27:22 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33635/tests/kraken/driver.html?testName=audio-dft) 00:27:22 INFO - PROCESS | 3236 | RSS: Main: 171417600 00:27:22 INFO - PROCESS | 3236 | 00:27:25 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33635/tests/kraken/driver.html?testName=audio-fft) 00:27:26 INFO - PROCESS | 3236 | RSS: Main: 166100992 00:27:26 INFO - PROCESS | 3236 | 00:27:28 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33635/tests/kraken/driver.html?testName=audio-oscillator) 00:27:29 INFO - PROCESS | 3236 | RSS: Main: 167038976 00:27:29 INFO - PROCESS | 3236 | 00:27:31 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33635/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:27:32 INFO - PROCESS | 3236 | RSS: Main: 167313408 00:27:32 INFO - PROCESS | 3236 | 00:27:35 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33635/tests/kraken/driver.html?testName=imaging-darkroom) 00:27:35 INFO - PROCESS | 3236 | RSS: Main: 167866368 00:27:35 INFO - PROCESS | 3236 | 00:27:39 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33635/tests/kraken/driver.html?testName=imaging-desaturate) 00:27:39 INFO - PROCESS | 3236 | RSS: Main: 168353792 00:27:39 INFO - PROCESS | 3236 | 00:27:42 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33635/tests/kraken/driver.html?testName=json-parse-financial) 00:27:43 INFO - PROCESS | 3236 | RSS: Main: 167731200 00:27:43 INFO - PROCESS | 3236 | 00:27:45 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33635/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:27:45 INFO - PROCESS | 3236 | RSS: Main: 168484864 00:27:45 INFO - PROCESS | 3236 | 00:27:47 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:27:48 INFO - PROCESS | 3236 | RSS: Main: 168763392 00:27:48 INFO - PROCESS | 3236 | 00:27:50 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:27:50 INFO - PROCESS | 3236 | RSS: Main: 169140224 00:27:50 INFO - PROCESS | 3236 | 00:27:53 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:27:54 INFO - PROCESS | 3236 | RSS: Main: 168902656 00:27:54 INFO - PROCESS | 3236 | 00:27:56 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:27:57 INFO - PROCESS | 3236 | RSS: Main: 168796160 00:27:57 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | Cycle 1(1): loaded http://localhost:33635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33635/tests/kraken/driver.html?testName=ai-astar) 00:27:59 INFO - PROCESS | 3236 | RSS: Main: 169639936 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | __start_tp_report 00:27:59 INFO - PROCESS | 3236 | _x_x_mozilla_page_load 00:27:59 INFO - PROCESS | 3236 | _x_x_mozilla_page_load_details 00:27:59 INFO - PROCESS | 3236 | |i|pagename|runs| 00:27:59 INFO - PROCESS | 3236 | |0;ai-astar;111;106;111;113;111;111;109;109;112;110 00:27:59 INFO - PROCESS | 3236 | |1;audio-beat-detection;163;126;158;177;129;153;155;126;193;133 00:27:59 INFO - PROCESS | 3236 | |2;audio-dft;161;162;162;162;161;165;172;163;162;164 00:27:59 INFO - PROCESS | 3236 | |3;audio-fft;75;76;76;159;79;75;75;75;164;76 00:27:59 INFO - PROCESS | 3236 | |4;audio-oscillator;84;83;153;85;83;83;140;83;83;137 00:27:59 INFO - PROCESS | 3236 | |5;imaging-gaussian-blur;119;118;118;118;117;117;117;122;117;118 00:27:59 INFO - PROCESS | 3236 | |6;imaging-darkroom;148;147;148;149;151;147;148;147;147;147 00:27:59 INFO - PROCESS | 3236 | |7;imaging-desaturate;100;96;96;96;95;95;96;96;95;96 00:27:59 INFO - PROCESS | 3236 | |8;json-parse-financial;54;56;61;53;55;54;57;54;55;56 00:27:59 INFO - PROCESS | 3236 | |9;json-stringify-tinderbox;63;62;62;62;63;62;62;63;62;62 00:27:59 INFO - PROCESS | 3236 | |10;stanford-crypto-aes;85;81;81;82;84;82;82;81;119;85 00:27:59 INFO - PROCESS | 3236 | |11;stanford-crypto-ccm;137;132;129;122;124;126;134;131;129;142 00:27:59 INFO - PROCESS | 3236 | |12;stanford-crypto-pbkdf2;162;164;159;159;162;161;164;161;160;159 00:27:59 INFO - PROCESS | 3236 | |13;stanford-crypto-sha256-iterative;65;65;68;64;66;62;63;64;65;63 00:27:59 INFO - PROCESS | 3236 | __end_tp_report 00:27:59 INFO - PROCESS | 3236 | __start_cc_report 00:27:59 INFO - PROCESS | 3236 | _x_x_mozilla_cycle_collect,909 00:27:59 INFO - PROCESS | 3236 | __end_cc_report 00:27:59 INFO - PROCESS | 3236 | __startTimestamp1464766079390__endTimestamp 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | ------- Summary: start ------- 00:27:59 INFO - PROCESS | 3236 | Number of tests: 14 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:2.05 00:27:59 INFO - PROCESS | 3236 | Values: 111.0 106.0 111.0 113.0 111.0 111.0 109.0 109.0 112.0 110.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:156.50 stddev:22.88 (14.6%) stddev-sans-first:23.87 00:27:59 INFO - PROCESS | 3236 | Values: 163.0 126.0 158.0 177.0 129.0 153.0 155.0 126.0 193.0 133.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.35 00:27:59 INFO - PROCESS | 3236 | Values: 161.0 162.0 162.0 162.0 161.0 165.0 172.0 163.0 162.0 164.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:36.14 (47.9%) stddev-sans-first:37.74 00:27:59 INFO - PROCESS | 3236 | Values: 75.0 76.0 76.0 159.0 79.0 75.0 75.0 75.0 164.0 76.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.00 stddev:29.22 (35.2%) stddev-sans-first:30.31 00:27:59 INFO - PROCESS | 3236 | Values: 84.0 83.0 153.0 85.0 83.0 83.0 140.0 83.0 83.0 137.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 00:27:59 INFO - PROCESS | 3236 | Values: 119.0 118.0 118.0 118.0 117.0 117.0 117.0 122.0 117.0 118.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 00:27:59 INFO - PROCESS | 3236 | Values: 148.0 147.0 148.0 149.0 151.0 147.0 148.0 147.0 147.0 147.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.45 (1.5%) stddev-sans-first:0.50 00:27:59 INFO - PROCESS | 3236 | Values: 100.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:2.27 (4.1%) stddev-sans-first:2.35 00:27:59 INFO - PROCESS | 3236 | Values: 54.0 56.0 61.0 53.0 55.0 54.0 57.0 54.0 55.0 56.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 00:27:59 INFO - PROCESS | 3236 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:82.00 stddev:11.63 (14.2%) stddev-sans-first:12.33 00:27:59 INFO - PROCESS | 3236 | Values: 85.0 81.0 81.0 82.0 84.0 82.0 82.0 81.0 119.0 85.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:131.50 stddev:6.04 (4.6%) stddev-sans-first:5.95 00:27:59 INFO - PROCESS | 3236 | Values: 137.0 132.0 129.0 122.0 124.0 126.0 134.0 131.0 129.0 142.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:1.91 (1.2%) stddev-sans-first:2.00 00:27:59 INFO - PROCESS | 3236 | Values: 162.0 164.0 159.0 159.0 162.0 161.0 164.0 161.0 160.0 159.0 00:27:59 INFO - PROCESS | 3236 | 00:27:59 INFO - PROCESS | 3236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.72 (2.6%) stddev-sans-first:1.81 00:27:59 INFO - PROCESS | 3236 | Values: 65.0 65.0 68.0 64.0 66.0 62.0 63.0 64.0 65.0 63.0 00:27:59 INFO - PROCESS | 3236 | -------- Summary: end -------- 00:27:59 INFO - PROCESS | 3236 | 00:28:00 INFO - TEST-INFO | 3236: exit 0 00:28:00 INFO - TEST-OK | kraken | took 61990ms 00:28:00 INFO - SUITE-END | took 1171s 00:28:00 INFO - Completed test suite (00:19:31) 00:28:00 INFO - javascript benchmark 00:28:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7146.868410106791, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.8754049837994, 3115.8597863096156, 3128.452520808858, 3138.4507711150573, 3149.1497295730137, 5330.200469929512, 5372.623916325859, 5382.838514844551, 5430.131179011359, 5437.32033495813, 5371.838844834661, 5442.292501974738, 5463.9180412293745, 5528.668279903209, 5544.112941929292, 4915.090708218991, 4933.481984391641, 4978.128827455199, 5057.873553161182, 5089.592832573385, 4933.777979990891, 5136.8715782105555, 5185.24813901984, 5201.401838788531, 5210.713410762407, 4915.582175515104, 4971.850844474671, 4987.6758010729545, 5015.974920125413, 5020.974895125538, 4984.252362145671, 4994.275830004665, 4996.650234483587, 4998.150314446517, 5054.1660625996665, 4986.152354099811, 4989.126902792033, 4992.500749925015, 4999.475055119233, 5032.370953630796, 5294.232336311214, 5354.9196762048605, 5390.568754499631, 5411.485908838694, 5422.267993820823, 5835.387284335168, 5847.532197424196, 5851.297844258716, 5855.795047173328, 5865.472107510302, 5660.235868157828, 5899.439553242435, 5904.0, 5907.438793314628, 5917.585768996172, 5361.839144825662, 5398.568114550826, 5410.3507579090365, 5423.918641220424, 5429.619926605139, 5928.822135335947, 5935.643861368246, 5935.73289201987, 5949.583529152917, 5952.166696662471, 5602.215689803431, 5673.517750991212, 5675.858103547362, 5691.943080569141, 5707.800226992118, 5813.6221145625395, 5880.0, 5892.175095486636, 5895.056790913519, 5936.465718085393, 5611.551075913999, 5624.634398764068, 5783.450572195635, 5824.155497452845, 5868.119782032729, 5677.0, 5678.3186017678145, 5684.147377893349, 5702.401247868997, 5738.254026976467, 4342.457192850894, 4348.195583817004, 4370.344448332712, 4373.628241599499, 4398.516163222043, 3900.414937759302, 3915.060385507458, 3916.412538119305, 3923.9019024524614, 3957.960420395817, 5582.134769110794, 5632.070708333079, 5662.235598194274, 5662.858428539237, 5734.0, 5890.0, 5901.645901245939, 5945.554083443672, 5958.463738263577, 5958.76164953397, 5494.2582751328855, 5541.418151094158, 5564.693941833238, 5602.879424115194, 5636.774529018793, 5018.42288136869, 5029.170186919117, 5042.697438153723, 5050.0, 5052.8484145475695, 6034.1853849730605, 6059.697914169303, 6070.544709146831, 6086.878262434727, 6117.480014198843, 5708.657480551097, 5851.268591426072, 5882.0, 5915.40845915405, 5948.970255148696, 6039.275286965592, 6074.635521868702, 6107.572469927062, 6115.296740874678, 6115.877682446415, 5584.078627026495, 5748.48263656273, 5807.245058142415, 5812.041013232769, 5817.94182058174, 5801.622894511843, 5845.3570107289015, 5885.47030767233, 5894.970525147347, 5920.970395147997, 5759.280089988752, 5769.913451298318, 5789.45000224978, 5790.478856902899, 5791.449812267828, 5522.6134170607675, 5630.408807075198, 5713.914291285717, 5723.7424315905055, 5744.569157313134, 5469.288992430958, 5536.695481748542, 5581.888362232814, 5596.18855265976, 5691.743871525874, 5649.265595472562, 5727.627704199213, 5729.0, 5738.598298119092, 5739.339975902658, 5396.676199428047, 5571.470710282679, 5593.741408183127, 5602.299712535933, 5606.719664016864], "value": 5379.700339589008, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1150656755017, 624.6907780648579, 636.503527248746, 639.2584601861838, 648.2674577727169, 42353.78823105884, 43553.78223108888, 43736.12527749447, 43960.3405948911, 46892.76553617236, 44363.33454998169, 45325.773371133095, 45336.546634533646, 45370.09259814802, 45377.092458150815, 8742.256908162797, 8947.150020748019, 8957.596908139149, 8964.058773828752, 8967.95516022419, 8747.518886461243, 8844.159804818564, 8848.380613357067, 8848.911510884873, 8863.734087977371, 8817.206451419372, 8924.68763593271, 8933.55332233389, 8936.731898043068, 8958.731238062835, 8830.161134692195, 8879.200871921526, 8908.465492070432, 8914.465132092095, 8921.241694455979, 8775.210231079169, 8821.07378725231, 8839.116088391109, 8845.0, 8871.955640221822, 41650.37524437136, 41968.16063678709, 42126.578734212875, 42131.57868421307, 42170.0, 3344.5652065231607, 3472.6006509251506, 3494.4234201356744, 3621.149029977953, 3859.749116307431, 32103.0, 32629.0, 32740.508892366634, 32743.18142046444, 32968.3406331872, 4269.829206831723, 4275.783021453679, 4337.154254920292, 4341.4790225172865, 4404.383386325917, 304858.0, 306833.0, 307426.0, 307876.46061769774, 309152.0, 57464.71267643635, 57607.711961440764, 57812.71093644505, 57822.39799209046, 58048.419515805144, 34791.4781278281, 35412.46881296731, 35696.821515892254, 37731.245375092345, 60413.09380359298, 17480.825191748176, 17499.475015749547, 17665.646687066444, 17701.114944252735, 17792.0, 13459.05786594929, 13459.05786594929, 13560.932195339157, 13566.864331356757, 13634.659133521742, 19597.020148992495, 19653.60692786136, 19784.20863165486, 19799.802001979795, 19844.107015184352, 7338.4496162788, 7401.555906645618, 7606.695732170762, 7672.80817979555, 7706.537607743553, 971.7424882406168, 1089.833877750815, 1102.97974373704, 1120.4061847220985, 1137.7496950670838, 32448.0, 32458.188545286557, 32610.673893260762, 32929.506057409155, 35556.64443355585, 1119.5801574409597, 1156.150229581257, 1175.0834349207632, 1210.1952201785714, 1235.1889390822873, 16399.508014759576, 16491.17544122813, 16600.6679866402, 16682.165891705365, 16859.747103793452, 509299.0, 509443.0, 509989.0, 514239.0, 515369.0, 54106.729466352415, 54285.72857135689, 54862.45137548653, 55110.44889551053, 55303.44696552983, 1211.8182272659171, 1226.22134944311, 1352.6579679229587, 1353.4112660992303, 1425.3229715884872, 30430.543541846448, 30651.693483065777, 30856.0, 31116.37767244597, 32044.0, 49858.75070624624, 50253.497465024884, 50260.49739502704, 50583.74708126436, 50777.74611126921, 442238.0, 444456.0, 444465.0, 445169.0, 448497.0, 24891.751082488943, 26737.19788406351, 26877.328066797705, 26942.73057269402, 27082.187534374, 46125.76937115293, 46536.301955471376, 46612.7669361651, 46832.53167468282, 47112.29331560098, 38709.80645096757, 38916.0, 39035.02412439712, 39607.60392396039, 39769.40345894756, 37360.43959340666, 38118.23763524769, 38201.0, 38928.22143557169, 39388.409173861844, 38707.6129238704, 39128.413073804484, 39202.43190272357, 39774.60225397825, 40030.19939601133, 34374.484382733775, 35222.8238858804, 35252.47121293234, 35319.646803531636, 35970.46044309285, 27539.0, 27774.44451110926, 27824.860875695493, 27972.30069248285, 27993.44013119767], "value": 19807.808794694145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5502329739259, 383.54358313606804, 389.6415297925908, 390.4241244164857, 396.51823035012455, 14933.850661493381, 17294.56763580911, 17635.29458821649, 19191.71212431813, 19308.61382772344, 18381.816181838178, 18382.90808545959, 18509.444716658523, 18690.15894284757, 18697.532561685966, 5089.3129427527365, 5549.972250138754, 5664.688442135681, 5697.116946873241, 5699.800506982257, 5607.0, 5610.186522954169, 5627.971860140714, 5632.662040277596, 5633.324001119871, 5424.566034717213, 5557.0, 5617.887642247153, 5646.435356464342, 5656.91514627281, 5454.1546060360315, 5609.691466969315, 5620.859478513049, 5651.689157096358, 5658.0381335172915, 5046.6719663221775, 5048.368953880765, 5063.772130254148, 5068.873278168038, 5073.416557095908, 21357.786422135734, 21477.785222147733, 21882.23412180566, 22484.10063597454, 22536.43658908524, 2195.8243340532717, 2203.7355517338024, 2305.827062970284, 2339.520398318358, 2368.218487898989, 13801.240931748749, 13874.306284685725, 14219.289035548285, 14241.572752817432, 14331.498397556035, 1935.9806401935941, 1998.7901270366692, 2044.2947183221765, 2056.4139220322136, 2056.5269987902716, 73929.0, 74693.99999999946, 75992.62003690001, 76485.23514764837, 77472.61263693702, 9712.514374281258, 9731.756706082404, 9993.201223779644, 10036.096751292418, 10207.948960255151, 11055.22613417053, 11770.764584708259, 13718.725625487434, 13796.241206733726, 13804.447822087004, 5527.44725527444, 5691.4877661010705, 6386.8722625547225, 7598.734044308423, 7697.191794861571, 7875.803104922423, 7982.840343193104, 8114.918850811417, 8156.632951517196, 8180.263776260165, 3409.232922592397, 3529.0471572675233, 3578.0, 3880.3403421418425, 4015.558288588253, 1946.5036415714185, 1968.4685135013754, 1973.9013049347475, 1978.5152637603878, 1985.4837742186846, 1023.1150055202196, 1029.5572903651503, 1068.433730123036, 1107.6953837694537, 1146.6344247998004, 17833.910830446024, 18038.729419058724, 18148.183331750104, 18152.818471815113, 18176.207989728035, 944.4852555357347, 950.6672664567346, 983.4836710726926, 1007.4106647611083, 1036.5594622285648, 8739.868901966476, 10302.484875756332, 10335.483225838678, 10337.0696637303, 10354.585816567253, 510906.0, 511969.0, 520621.0, 529066.0, 538071.0, 89733.0, 92401.0, 92436.0, 93642.0, 94338.0, 1012.71643939697, 1023.2070145637042, 1023.4166525080633, 1046.9110125639406, 1050.4327663062013, 15975.680486389974, 16211.35154593803, 16276.67446651084, 16381.344746210018, 16500.42248521344, 30827.95419572737, 40839.7958010208, 40963.1807363857, 41003.0, 41140.177196456505, 55564.72217638886, 55930.720346398004, 57021.0, 57699.71150144222, 57967.71016144892, 6613.43785778195, 6951.895721564079, 8180.713675021346, 8293.792655183428, 8318.584070796556, 11435.656930292105, 12502.124851260325, 12567.24596524175, 12748.872511274769, 12816.010535347332, 11071.1696622752, 11134.55461781552, 11327.263727857662, 11388.37363944991, 11398.373089480157, 10964.06805421548, 11077.0, 11154.944225278821, 11156.386398747822, 11208.0, 11036.944815275872, 11051.0, 11318.32090074598, 11398.316101033965, 11460.312381257152, 7174.605396703231, 7229.060222171084, 7239.914012897897, 7244.203137654748, 7894.921050789419, 8003.799905002422, 10232.334898231591, 11373.260738052, 11541.249818761753, 11567.76864462723], "value": 8842.163914921059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.7030593881223, 1497.191516581046, 1696.4995326378726, 1815.7367181758655, 1850.6668799616064, 7678.846423071535, 8641.870371944418, 8667.523286219255, 9250.953745231272, 9253.537323133842, 8681.04508504064, 8900.1544853239, 8957.104289571056, 8971.0, 8971.685990990316, 2327.464683122883, 2346.343023953296, 2370.8577485350934, 2371.4664200554907, 2372.7508611595795, 2308.3190458814606, 2334.1830359374253, 2361.0909799727056, 2368.798652114572, 2377.2986968844148, 2307.469282065126, 2321.58211521926, 2339.9532009359805, 2373.193114341124, 2375.1449478187837, 2265.2411442166813, 2290.541891621682, 2295.850769699964, 2304.158981971585, 2329.6039673255586, 2260.400993736661, 2263.7283525976823, 2266.7506574276817, 2278.931632051041, 2285.611446054175, 8926.419782714103, 9004.964429090673, 9009.459432434074, 9011.143941325563, 9016.413933094393, 5342.2253773202665, 5478.287822583039, 5482.396936337, 5485.341758988907, 5489.58828087895, 3054.404391143728, 3153.369326134782, 3255.6744325567493, 3258.885938992124, 3259.1526203187104, 960.4333443268436, 977.1010670183448, 978.8189185000798, 1030.9123724483352, 1041.5209003858233, 12652.557160499431, 12703.491860325576, 12711.809322860072, 12722.681932951658, 12743.745125097446, 4615.861524154281, 4772.189040646986, 4852.660313778002, 4852.975735121372, 4853.247746599282, 10520.947395262974, 10598.947005264925, 10618.150547956146, 10632.46837658114, 10663.146948244123, 5337.866553336197, 5359.5712343012465, 5407.567394608422, 5414.187871819258, 5480.3971563128025, 4433.224185767478, 4838.879028024327, 4922.433920099163, 4932.0135972804865, 4975.303457515951, 3984.9800750996637, 3985.8405663773706, 4073.877783666495, 4085.3667681509414, 4132.607402296777, 1261.7224210673637, 1269.8666640002666, 1272.3765354975994, 1277.552856500236, 1296.027979015738, 983.4640121133999, 996.6362277768707, 1002.2282842211456, 1002.2983911262, 1007.9647212347533, 5900.675462849585, 5975.37258587842, 6033.215681961317, 6066.090086487062, 6132.264128304632, 447.9596836284685, 455.6605329029894, 459.38213103375904, 460.1165761737472, 461.25967821646447, 3956.4460975462885, 4117.1765646870745, 4122.093139509303, 4136.0, 4142.233686767958, 10674.146068314516, 11154.330740155616, 11160.274582152297, 11192.888071119347, 11205.66383008511, 10827.945860270805, 10937.015668589866, 11011.174161937886, 11062.336259824437, 11132.220744547803, 8066.596670166468, 8554.828903421896, 8607.741767746978, 8615.569221538897, 8619.094995025558, 6148.1699970503405, 6281.7173227203975, 6283.37166283368, 6389.105525226379, 6401.455876250571, 10233.48832558384, 10421.895781042092, 10438.53026613789, 10512.684619461428, 10552.894471055191, 10465.47672616351, 10497.842532362174, 10672.946635266773, 10752.0, 10777.676669699922, 7310.488265821342, 7599.772006839804, 7867.9606601966625, 8049.0, 8093.231143041402, 8612.526311052952, 8656.264217541328, 8674.045854956075, 8675.175858293453, 8743.650253990023, 7738.303552680286, 7798.922010779819, 7876.369890408639, 7985.680572777256, 8015.358771298399, 7484.887726684213, 7674.8081297968, 7714.305712485903, 7762.301392874669, 7769.067711874612, 6998.685059172248, 7036.8592628146125, 7038.436925045881, 7058.682359293742, 7080.575165490087, 5300.761465733974, 5391.16436952273, 5434.2392065110125, 5454.318210223722, 5457.263269458573, 5223.712695801767, 5403.891922161613, 5453.890922181614, 5457.590680698884, 5602.1036634138345], "value": 4616.07870006524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.61307235232425, 303.7463717795641, 313.3669986627015, 313.778785955901, 315.86575705325237, 5327.334083239595, 5400.864978375543, 5559.9444005559935, 5632.042552766029, 5666.660000399974, 5551.72241387931, 5584.888302233953, 5594.86012849679, 5596.496315331619, 5602.523785478229, 4261.50992635847, 4268.59448352406, 4295.334223195394, 4316.7194132381455, 4341.1317736452675, 4106.630403263705, 4302.935455968163, 4303.934111626421, 4320.07118469529, 4332.9566704332865, 4187.685923555746, 4229.555896630855, 4238.639715624176, 4264.104538046999, 4272.87181384559, 4222.936655950163, 4229.133027729339, 4263.701540892123, 4274.786260686984, 4287.978560107195, 3563.6614521620663, 3671.3575124353133, 3698.149425632093, 3698.408254679265, 3712.795796231206, 5390.595705322077, 5400.891982160335, 5422.240886275925, 5443.836684899459, 5498.752556134944, 4803.831865884677, 4822.421309442854, 4854.466008739036, 4878.219484882402, 4902.215645496739, 5637.661740295595, 5813.360530341659, 5822.796202132905, 5861.0, 5861.5603829712945, 4057.2696914555368, 4070.247004304213, 4078.490188726409, 4092.4270602115726, 4119.711620186558, 6144.293406258293, 6152.261728592597, 6166.260048794174, 6170.0, 6178.598391104609, 3967.8412863485137, 4173.873054275328, 4190.141021090669, 4208.894777630522, 4220.311875249863, 4169.332906734908, 4199.404226393951, 4256.297710877732, 4266.338717498793, 4273.273543497613, 4851.248056551241, 4882.536159064884, 4883.218685010382, 4921.351347298623, 4930.309756634074, 5288.202011316094, 5831.300243970751, 5835.0, 5895.67573783446, 5975.25309336333, 1467.889908256885, 1478.4455829064102, 1484.3246322923044, 1487.133647272666, 1488.3674438363653, 898.9706785730302, 934.514052692596, 938.1603464898877, 947.1806887042659, 953.2755106119399, 4982.950170498321, 5003.949960500421, 5010.918285254542, 5031.84904452867, 5037.370328708911, 5233.816816411408, 5349.1976203569, 5359.839204823861, 5402.540784033401, 5440.91838622421, 5081.212412076134, 5115.539601435814, 5145.511176438233, 5355.839324820184, 5822.650640961556, 3200.7919485233383, 3212.1969507623094, 3264.477683570665, 3265.2000259935994, 3272.3128143089743, 6047.274327080779, 6276.497880169575, 6276.686165691697, 6315.179026726496, 6315.842103947346, 6117.602355846945, 6128.233970753656, 6132.356102609251, 6154.415330543591, 6172.321044685081, 6261.0, 6264.937350626436, 6290.00584628764, 6310.116583678288, 6319.399657032574, 5789.2763404574425, 6032.526664067711, 6055.697215139137, 6071.574989750675, 6110.450059494667, 5968.641881487125, 5978.551608629283, 5984.760609575568, 6004.699765011645, 6024.186734790747, 5947.434993675594, 6248.968755156195, 6253.843653908689, 6276.717547710273, 6294.181756371826, 4114.691398145092, 4127.318992366226, 4142.751434913915, 4172.457580514514, 4177.516981471534, 5785.450382213683, 5879.618754404473, 6056.333803281547, 6067.605605635797, 6071.453569178795, 5904.663864916309, 5933.821985340447, 5940.851478713067, 5961.688428545713, 5968.194293770285, 5844.327902291291, 5907.232059832194, 5944.762209511744, 5948.583599148018, 5968.283805943314, 5558.194061860927, 5737.454941780524, 5759.0209664356325, 5766.509846663081, 5846.327672317738, 5952.255968003999, 5954.404559544011, 5963.522918166623, 6000.87998240024, 6027.758889644365, 5707.800226992035, 5744.827655170351, 5770.855728606651, 5860.589758716849, 5888.586739182651], "value": 4386.960540650025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.6080281464897, 836.1972506393862, 838.4172999765162, 852.2585350744853, 853.6798700487317, 15219.543413697578, 15719.449819256328, 15822.05067695939, 15847.286872090755, 15853.0, 11406.657800266004, 14545.0, 14617.561473155796, 14645.121292722444, 14661.486847960323, 804.7505273365247, 821.9219174178444, 822.6668199379261, 829.8049958259834, 830.0910502999236, 816.7304789419477, 818.7543736878943, 819.4304958054155, 822.383212590557, 823.4071468542639, 865.5672163918041, 866.3199388480044, 871.777696687347, 875.5578432891381, 875.5797217335651, 853.6158728572105, 855.8117214212863, 857.9270761985239, 858.1675774498726, 864.4942708515526, 629.0972454527767, 630.4641055103126, 631.6115588912786, 633.6926590603554, 634.5494698763883, 14484.927575362055, 14548.636284092983, 14552.563423097325, 14571.489997850025, 14580.198089105095, 14159.575212743634, 14229.0, 14260.0, 14273.71452570953, 14328.426862925471, 11584.768304633944, 11709.648710538613, 11740.236884602558, 11770.940615344574, 12084.879151208552, 3825.5600605930395, 3866.9613303867163, 3938.330483817758, 3943.7633741975574, 4031.697622678311, 53046.46953530454, 54598.454015460135, 60050.699746500984, 60072.098918516254, 60507.394926051056, 10468.947655261827, 10687.51906164209, 10944.23390362683, 11001.724956876142, 11172.923052426297, 19668.508287292647, 19813.0, 19903.303384381477, 19913.800861991484, 20039.398818035483, 7956.085050219183, 8077.0, 8240.62917168729, 8300.169983001651, 8301.709440169565, 4786.401699787527, 4814.325994360793, 4859.07677541266, 4945.2087665973995, 4974.626902982291, 3375.9493607595905, 3412.061683037135, 3443.7589368743947, 3483.076984599083, 3494.143934735955, 620.218524658933, 637.6588525139028, 638.0365647871747, 640.1198352265635, 655.8195248552586, 612.3233826621608, 644.2011905237472, 704.2710794327846, 712.7362875735907, 751.3463286940397, 8703.869441958375, 8738.781530461662, 8770.473771573726, 8805.779855503535, 9016.18854303116, 698.7030512032366, 709.6345382128105, 714.1109318897901, 718.8202949262684, 735.3308489274841, 4047.170330082326, 4124.628783409507, 4144.70987030911, 4231.894202644959, 4292.18448494785, 60812.0, 61091.69454152701, 62248.37751622516, 62555.68722156451, 63345.366546334866, 62921.370786291554, 62952.37047629465, 63343.36656633467, 64399.0, 64738.0, 52371.73814130905, 53847.0, 53870.191947120824, 59456.405435945955, 59570.80858382808, 8821.073787252502, 9013.18881300686, 9057.637694492147, 9132.908670913206, 9141.720159177854, 38754.6124538751, 38985.0, 39397.21205575815, 40128.398074029494, 40418.0, 51197.744011279705, 52227.73886130545, 52856.47143528515, 53041.0, 54429.72785136049, 12444.191127576678, 12500.93749531283, 12515.37423128858, 12572.931873782334, 12795.80806287925, 13834.912955545558, 13836.100653457494, 14130.92934535362, 14139.222342770834, 14360.784588230976, 13074.150180238254, 13493.730125397633, 13500.122492037986, 13549.458021679022, 13885.166889986633, 12997.480100795863, 13098.672533186747, 13318.40067196998, 13653.795193071914, 13684.931575342458, 12726.363681815687, 12921.28932908699, 13571.050026498051, 13757.38091785852, 13766.0, 10461.843072354073, 10744.194185435967, 10754.89245107539, 11082.390468523987, 11103.333799972028, 11307.265027773168, 11349.14881383883, 11374.829377559177, 11550.48022838991, 11816.350100744541], "value": 6983.32532272927, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 113.0, 111.0, 111.0, 109.0, 109.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 158.0, 177.0, 129.0, 153.0, 155.0, 126.0, 193.0, 133.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 165.0, 172.0, 163.0, 162.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 159.0, 79.0, 75.0, 75.0, 75.0, 164.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 153.0, 85.0, 83.0, 83.0, 140.0, 83.0, 83.0, 137.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 122.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 151.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 61.0, 53.0, 55.0, 54.0, 57.0, 54.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 81.0, 82.0, 84.0, 82.0, 82.0, 81.0, 119.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 129.0, 122.0, 124.0, 126.0, 134.0, 131.0, 129.0, 142.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 159.0, 159.0, 162.0, 161.0, 164.0, 161.0, 160.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 64.0, 66.0, 62.0, 63.0, 64.0, 65.0, 63.0], "value": 64.5, "unit": "score"}]}]} 00:28:00 INFO - Return code: 0 00:28:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:28:00 ERROR - # TBPL SUCCESS # 00:28:00 INFO - Running post-action listener: _resource_record_post_action 00:28:00 INFO - ##### 00:28:00 INFO - ##### Finished run-tests step (success) 00:28:00 INFO - ##### 00:28:00 INFO - Running post-run listener: _resource_record_post_run 00:28:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545415168; Read time: 16; Write time: 370392 00:28:00 INFO - TinderboxPrint: CPU usage
13.4% 00:28:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:28:00 INFO - TinderboxPrint: I/O write bytes / time
545,415,168 / 370,392 00:28:00 INFO - TinderboxPrint: CPU idle
8,221.0 (86.6%) 00:28:00 INFO - TinderboxPrint: CPU user
1,219.0 (12.8%) 00:28:00 INFO - TinderboxPrint: Swap in / out
0 / 0 00:28:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 215224320; Read time: 0; Write time: 194420 00:28:00 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296898560; Read time: 16; Write time: 166860 00:28:01 INFO - Running post-run listener: _upload_blobber_files 00:28:01 INFO - Blob upload gear active. 00:28:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:28:01 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 00:28:01 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'] 00:28:01 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 00:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 00:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:05 INFO - (blobuploader) - INFO - Done attempting. 00:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:06 INFO - (blobuploader) - INFO - Done attempting. 00:28:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:28:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:08 INFO - (blobuploader) - INFO - Done attempting. 00:28:08 INFO - (blobuploader) - INFO - Iteration through files over. 00:28:08 INFO - Return code: 0 00:28:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:28:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:28:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add4df91e2db05af2cff07e62e8f8b14cdb7e6fd92f25917e3835174b027c15dc7ff88ae621b579992c45c5b9af127eeaf1bc7e18ab793243dabc25a12660908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c115133284eacaa09578b296139421ea53fc7860b3d306b870adf1ef04fd4399ca8749dc8509549a9c3b409b5a0edc313f8610cd84a3e60fecb097c797d47f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1893e4063b8fee962a71df91959e341428723621332d8e54ef294174c0d2c2e43aef4741bf7ee89064236f6254c843122cbe55f5421555e01ab3d7c70fa2c3a"} 00:28:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:28:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:28:08 INFO - Contents: 00:28:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add4df91e2db05af2cff07e62e8f8b14cdb7e6fd92f25917e3835174b027c15dc7ff88ae621b579992c45c5b9af127eeaf1bc7e18ab793243dabc25a12660908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c115133284eacaa09578b296139421ea53fc7860b3d306b870adf1ef04fd4399ca8749dc8509549a9c3b409b5a0edc313f8610cd84a3e60fecb097c797d47f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1893e4063b8fee962a71df91959e341428723621332d8e54ef294174c0d2c2e43aef4741bf7ee89064236f6254c843122cbe55f5421555e01ab3d7c70fa2c3a"} 00:28:08 INFO - Running post-run listener: copy_logs_to_upload_dir 00:28:08 INFO - Copying logs to upload dir... 00:28:08 INFO - mkdir: /builds/slave/test/build/upload/logs 00:28:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.667127 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 00:28:07.883250) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 00:28:07.887146) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 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/add4df91e2db05af2cff07e62e8f8b14cdb7e6fd92f25917e3835174b027c15dc7ff88ae621b579992c45c5b9af127eeaf1bc7e18ab793243dabc25a12660908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c115133284eacaa09578b296139421ea53fc7860b3d306b870adf1ef04fd4399ca8749dc8509549a9c3b409b5a0edc313f8610cd84a3e60fecb097c797d47f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1893e4063b8fee962a71df91959e341428723621332d8e54ef294174c0d2c2e43aef4741bf7ee89064236f6254c843122cbe55f5421555e01ab3d7c70fa2c3a"} build_url:https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/dEIeclrgR1-yvml5v-Utxg/artifacts/public/build/firefox-49.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/add4df91e2db05af2cff07e62e8f8b14cdb7e6fd92f25917e3835174b027c15dc7ff88ae621b579992c45c5b9af127eeaf1bc7e18ab793243dabc25a12660908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c115133284eacaa09578b296139421ea53fc7860b3d306b870adf1ef04fd4399ca8749dc8509549a9c3b409b5a0edc313f8610cd84a3e60fecb097c797d47f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1893e4063b8fee962a71df91959e341428723621332d8e54ef294174c0d2c2e43aef4741bf7ee89064236f6254c843122cbe55f5421555e01ab3d7c70fa2c3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 00:28:07.918375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:28:07.918720) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464763611.764520-211091843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 00:28:08.003900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 00:28:08.004901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 00:28:08.005750) ========= ========= Total master_lag: 0.37 =========