builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1463696417.99 results: success (0) buildid: 20160519113040 builduid: 14fd5e3939b34f49b38a0dd8c17ee9f4 revision: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:17.985831) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:17.986303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:17.986648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.023576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.023987) ========= 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=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 15:20:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-19 15:20:18 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.164451) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.164793) ========= 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=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.215355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.215726) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 --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 a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 --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=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 15:20:18,870 truncating revision to first 12 chars 2016-05-19 15:20:18,870 Setting DEBUG logging. 2016-05-19 15:20:18,870 attempt 1/10 2016-05-19 15:20:18,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3eb9950fa4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 15:20:19,165 unpacking tar archive at: fx-team-a3eb9950fa4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.795619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.796384) ========= script_repo_revision: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.797159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.797471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 15:20:18.808390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 15:20:18.809263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:20:19 INFO - MultiFileLogger online at 20160519 15:20:19 in /builds/slave/test 15:20:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:20:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:19 INFO - {'append_to_log': False, 15:20:19 INFO - 'base_work_dir': '/builds/slave/test', 15:20:19 INFO - 'blob_upload_branch': 'Fx-Team', 15:20:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:19 INFO - 'branch': 'Fx-Team', 15:20:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:19 INFO - 'config_files': ('talos/linux_config.py',), 15:20:19 INFO - 'default_actions': ('clobber', 15:20:19 INFO - 'read-buildbot-config', 15:20:19 INFO - 'download-and-extract', 15:20:19 INFO - 'populate-webroot', 15:20:19 INFO - 'create-virtualenv', 15:20:19 INFO - 'install', 15:20:19 INFO - 'run-tests'), 15:20:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:19 INFO - 'download_minidump_stackwalk': True, 15:20:19 INFO - 'download_symbols': 'ondemand', 15:20:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:19 INFO - 'installer_path': 'installer.exe', 15:20:19 INFO - 'log_level': 'info', 15:20:19 INFO - 'log_name': 'talos', 15:20:19 INFO - 'log_to_console': True, 15:20:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:20:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:20:19 INFO - 'opt_config_files': (), 15:20:19 INFO - 'pip_index': False, 15:20:19 INFO - 'sps_profile': False, 15:20:19 INFO - 'sps_profile_interval': 0, 15:20:19 INFO - 'suite': 'dromaeojs', 15:20:19 INFO - 'system_bits': '32', 15:20:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:19 INFO - 'title': 'talos-linux64-ix-056', 15:20:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:19 INFO - 'use_talos_json': True, 15:20:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:19 INFO - 'work_dir': 'build'} 15:20:19 INFO - ##### 15:20:19 INFO - ##### Running clobber step. 15:20:19 INFO - ##### 15:20:19 INFO - Running pre-action listener: _resource_record_pre_action 15:20:19 INFO - Running main action method: clobber 15:20:19 INFO - rmtree: /builds/slave/test/build 15:20:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:20 INFO - Running post-action listener: _resource_record_post_action 15:20:20 INFO - ##### 15:20:20 INFO - ##### Finished clobber step (success) 15:20:20 INFO - ##### 15:20:20 INFO - ##### 15:20:20 INFO - ##### Running read-buildbot-config step. 15:20:20 INFO - ##### 15:20:20 INFO - Running pre-action listener: _resource_record_pre_action 15:20:20 INFO - Running main action method: read_buildbot_config 15:20:20 INFO - Using buildbot properties: 15:20:20 INFO - { 15:20:20 INFO - "project": "", 15:20:20 INFO - "product": "firefox", 15:20:20 INFO - "script_repo_revision": "production", 15:20:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:20:20 INFO - "repository": "", 15:20:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:20:20 INFO - "buildid": "20160519113040", 15:20:20 INFO - "pgo_build": "True", 15:20:20 INFO - "basedir": "/builds/slave/test", 15:20:20 INFO - "buildnumber": 108, 15:20:20 INFO - "slavename": "talos-linux64-ix-056", 15:20:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:20:20 INFO - "platform": "ubuntu64_hw", 15:20:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:20:20 INFO - "branch": "fx-team", 15:20:20 INFO - "repo_path": "integration/fx-team", 15:20:20 INFO - "revision": "a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35", 15:20:20 INFO - "stage_platform": "linux64-pgo", 15:20:20 INFO - "builduid": "14fd5e3939b34f49b38a0dd8c17ee9f4", 15:20:20 INFO - "slavebuilddir": "test" 15:20:20 INFO - } 15:20:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:20:20 INFO - Running post-action listener: _resource_record_post_action 15:20:20 INFO - ##### 15:20:20 INFO - ##### Finished read-buildbot-config step (success) 15:20:20 INFO - ##### 15:20:20 INFO - ##### 15:20:20 INFO - ##### Running download-and-extract step. 15:20:20 INFO - ##### 15:20:20 INFO - Running pre-action listener: _resource_record_pre_action 15:20:20 INFO - Running main action method: download_and_extract 15:20:20 INFO - mkdir: /builds/slave/test/build/tests 15:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:20 INFO - https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:20:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:20 INFO - Downloaded 1361 bytes. 15:20:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:20 INFO - Using the following test package requirements: 15:20:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:20:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:20:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'jsshell-linux-x86_64.zip'], 15:20:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:20:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:20:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:20:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:20:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:20:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:20 INFO - https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:21 INFO - Downloaded 24387626 bytes. 15:20:21 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'] 15:20:21 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 15:20:23 INFO - Return code: 0 15:20:23 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 15:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:23 INFO - https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:24 INFO - Downloaded 24387626 bytes. 15:20:24 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'] 15:20:24 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 15:20:26 INFO - Return code: 0 15:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:26 INFO - https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:29 INFO - Downloaded 10840359 bytes. 15:20:29 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'] 15:20:29 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 15:20:29 INFO - Return code: 0 15:20:29 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')]} 15:20:29 INFO - https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:20:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/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 15:20:31 INFO - Downloaded 58600006 bytes. 15:20:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:31 INFO - mkdir: /builds/slave/test/properties 15:20:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:20:31 INFO - Writing to file /builds/slave/test/properties/build_url 15:20:31 INFO - Contents: 15:20:31 INFO - build_url:https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:32 INFO - Running post-action listener: _resource_record_post_action 15:20:32 INFO - Running post-action listener: set_extra_try_arguments 15:20:32 INFO - ##### 15:20:32 INFO - ##### Finished download-and-extract step (success) 15:20:32 INFO - ##### 15:20:32 INFO - ##### 15:20:32 INFO - ##### Running populate-webroot step. 15:20:32 INFO - ##### 15:20:32 INFO - Running pre-action listener: _resource_record_pre_action 15:20:32 INFO - Running main action method: populate_webroot 15:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:20:32 INFO - '--tppagecycles', 15:20:32 INFO - '7'], 15:20:32 INFO - 'tests': ['tsvgm']}}, 15:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:20:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['damp', 'tps']}, 15:20:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'tests': ['damp', 'tps']}, 15:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['dromaeo_dom']}, 15:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['a11yr', 15:20:32 INFO - 'ts_paint', 15:20:32 INFO - 'tpaint', 15:20:32 INFO - 'sessionrestore', 15:20:32 INFO - 'sessionrestore_no_auto_restore', 15:20:32 INFO - 'tabpaint']}, 15:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['tsvgx', 15:20:32 INFO - 'tsvgr_opacity', 15:20:32 INFO - 'tart', 15:20:32 INFO - 'tscrollx', 15:20:32 INFO - 'cart']}, 15:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:20:32 INFO - 'tsvgr_opacity', 15:20:32 INFO - 'tart', 15:20:32 INFO - 'tscrollx', 15:20:32 INFO - 'cart']}, 15:20:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'talos_options': ['--disable-e10s'], 15:20:32 INFO - 'tests': ['tp5o']}, 15:20:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'tests': ['tp5o']}, 15:20:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'talos_options': ['--disable-e10s', 15:20:32 INFO - '--xperf_path', 15:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:32 INFO - 'tests': ['tp5n']}, 15:20:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:32 INFO - 'talos_options': ['--xperf_path', 15:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:32 INFO - 'tests': ['tp5n']}}, 15:20:32 INFO - 'talos.zip': {'path': '', 15:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:20:32 INFO - Running post-action listener: _resource_record_post_action 15:20:32 INFO - ##### 15:20:32 INFO - ##### Finished populate-webroot step (success) 15:20:32 INFO - ##### 15:20:32 INFO - ##### 15:20:32 INFO - ##### Running create-virtualenv step. 15:20:32 INFO - ##### 15:20:32 INFO - Running pre-action listener: _resource_record_pre_action 15:20:32 INFO - Running main action method: create_virtualenv 15:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:20:32 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 15:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:20:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:20:32 INFO - Using real prefix '/usr' 15:20:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:20:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:35 INFO - Installing pip.................done. 15:20:35 INFO - Return code: 0 15:20:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:35 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 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:35 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 15:20:35 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 15:20:35 INFO - Using env: {'DISPLAY': ':0', 15:20:35 INFO - 'HOME': '/home/cltbld', 15:20:35 INFO - 'LANG': 'en_US.UTF-8', 15:20:35 INFO - 'LANGUAGE': 'en_US:en', 15:20:35 INFO - 'LOGNAME': 'cltbld', 15:20:35 INFO - 'MAIL': '/var/mail/cltbld', 15:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:35 INFO - 'MOZ_NO_REMOTE': '1', 15:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:35 INFO - 'NO_EM_RESTART': '1', 15:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:35 INFO - 'PWD': '/builds/slave/test', 15:20:35 INFO - 'SHELL': '/bin/bash', 15:20:35 INFO - 'SHLVL': '1', 15:20:35 INFO - 'TERM': 'linux', 15:20:35 INFO - 'TMOUT': '86400', 15:20:35 INFO - 'USER': 'cltbld', 15:20:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:35 INFO - '_': '/tools/buildbot/bin/python'} 15:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:35 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 15:20:35 INFO - Cleaning up... 15:20:35 INFO - Return code: 0 15:20:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:35 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 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:35 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 15:20:35 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 15:20:35 INFO - Using env: {'DISPLAY': ':0', 15:20:35 INFO - 'HOME': '/home/cltbld', 15:20:35 INFO - 'LANG': 'en_US.UTF-8', 15:20:35 INFO - 'LANGUAGE': 'en_US:en', 15:20:35 INFO - 'LOGNAME': 'cltbld', 15:20:35 INFO - 'MAIL': '/var/mail/cltbld', 15:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:35 INFO - 'MOZ_NO_REMOTE': '1', 15:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:35 INFO - 'NO_EM_RESTART': '1', 15:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:35 INFO - 'PWD': '/builds/slave/test', 15:20:35 INFO - 'SHELL': '/bin/bash', 15:20:35 INFO - 'SHLVL': '1', 15:20:35 INFO - 'TERM': 'linux', 15:20:35 INFO - 'TMOUT': '86400', 15:20:35 INFO - 'USER': 'cltbld', 15:20:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:35 INFO - '_': '/tools/buildbot/bin/python'} 15:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:35 INFO - Downloading/unpacking psutil>=3.1.1 15:20:35 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 15:20:35 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 15:20:35 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 15:20:35 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 15:20:35 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 15:20:35 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 15:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:37 INFO - Installing collected packages: psutil 15:20:37 INFO - Running setup.py install for psutil 15:20:37 INFO - building 'psutil._psutil_linux' extension 15:20:37 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 15:20:37 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 15:20:37 INFO - building 'psutil._psutil_posix' extension 15:20:37 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 15:20:38 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 15:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:38 INFO - Successfully installed psutil 15:20:38 INFO - Cleaning up... 15:20:38 INFO - Return code: 0 15:20:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:20:38 INFO - Using env: {'DISPLAY': ':0', 15:20:38 INFO - 'HOME': '/home/cltbld', 15:20:38 INFO - 'LANG': 'en_US.UTF-8', 15:20:38 INFO - 'LANGUAGE': 'en_US:en', 15:20:38 INFO - 'LOGNAME': 'cltbld', 15:20:38 INFO - 'MAIL': '/var/mail/cltbld', 15:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:38 INFO - 'MOZ_NO_REMOTE': '1', 15:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:38 INFO - 'NO_EM_RESTART': '1', 15:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:38 INFO - 'PWD': '/builds/slave/test', 15:20:38 INFO - 'SHELL': '/bin/bash', 15:20:38 INFO - 'SHLVL': '1', 15:20:38 INFO - 'TERM': 'linux', 15:20:38 INFO - 'TMOUT': '86400', 15:20:38 INFO - 'USER': 'cltbld', 15:20:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:38 INFO - '_': '/tools/buildbot/bin/python'} 15:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20:38 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 15:20:38 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 15:20:38 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 15:20:38 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 15:20:38 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 15:20:38 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 15:20:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:40 INFO - Installing collected packages: mozsystemmonitor 15:20:40 INFO - Running setup.py install for mozsystemmonitor 15:20:40 INFO - Successfully installed mozsystemmonitor 15:20:40 INFO - Cleaning up... 15:20:40 INFO - Return code: 0 15:20:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 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 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:40 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 15:20:40 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 15:20:40 INFO - Using env: {'DISPLAY': ':0', 15:20:40 INFO - 'HOME': '/home/cltbld', 15:20:40 INFO - 'LANG': 'en_US.UTF-8', 15:20:40 INFO - 'LANGUAGE': 'en_US:en', 15:20:40 INFO - 'LOGNAME': 'cltbld', 15:20:40 INFO - 'MAIL': '/var/mail/cltbld', 15:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:40 INFO - 'MOZ_NO_REMOTE': '1', 15:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:40 INFO - 'NO_EM_RESTART': '1', 15:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:40 INFO - 'PWD': '/builds/slave/test', 15:20:40 INFO - 'SHELL': '/bin/bash', 15:20:40 INFO - 'SHLVL': '1', 15:20:40 INFO - 'TERM': 'linux', 15:20:40 INFO - 'TMOUT': '86400', 15:20:40 INFO - 'USER': 'cltbld', 15:20:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:40 INFO - '_': '/tools/buildbot/bin/python'} 15:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:40 INFO - Downloading/unpacking blobuploader==1.2.4 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20:42 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 15:20:42 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 15:20:42 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 15:20:42 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 15:20:42 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 15:20:42 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 15:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:43 INFO - Downloading docopt-0.6.1.tar.gz 15:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:43 INFO - Running setup.py install for blobuploader 15:20:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:43 INFO - Running setup.py install for requests 15:20:43 INFO - Running setup.py install for docopt 15:20:43 INFO - Successfully installed blobuploader requests docopt 15:20:43 INFO - Cleaning up... 15:20:44 INFO - Return code: 0 15:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:44 INFO - Using env: {'DISPLAY': ':0', 15:20:44 INFO - 'HOME': '/home/cltbld', 15:20:44 INFO - 'LANG': 'en_US.UTF-8', 15:20:44 INFO - 'LANGUAGE': 'en_US:en', 15:20:44 INFO - 'LOGNAME': 'cltbld', 15:20:44 INFO - 'MAIL': '/var/mail/cltbld', 15:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:44 INFO - 'MOZ_NO_REMOTE': '1', 15:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:44 INFO - 'NO_EM_RESTART': '1', 15:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:44 INFO - 'PWD': '/builds/slave/test', 15:20:44 INFO - 'SHELL': '/bin/bash', 15:20:44 INFO - 'SHLVL': '1', 15:20:44 INFO - 'TERM': 'linux', 15:20:44 INFO - 'TMOUT': '86400', 15:20:44 INFO - 'USER': 'cltbld', 15:20:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:44 INFO - '_': '/tools/buildbot/bin/python'} 15:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:44 INFO - Running setup.py (path:/tmp/pip-7iqOM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:44 INFO - Running setup.py (path:/tmp/pip-hqTtDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:44 INFO - Running setup.py (path:/tmp/pip-I5wxG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:44 INFO - Running setup.py (path:/tmp/pip-FDWvA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:44 INFO - Running setup.py (path:/tmp/pip-1FAiJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:44 INFO - Running setup.py (path:/tmp/pip-9ZxhtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:44 INFO - Running setup.py (path:/tmp/pip-ke8iyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:44 INFO - Running setup.py (path:/tmp/pip-QaGdb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:44 INFO - Running setup.py (path:/tmp/pip-B5okYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:44 INFO - Running setup.py (path:/tmp/pip-MeMcVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:44 INFO - Running setup.py (path:/tmp/pip-yodsZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:45 INFO - Running setup.py (path:/tmp/pip-5UoEiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:45 INFO - Running setup.py (path:/tmp/pip-mFkmJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:45 INFO - Running setup.py (path:/tmp/pip-ekqr17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:45 INFO - Running setup.py (path:/tmp/pip-VX8CdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:45 INFO - Running setup.py (path:/tmp/pip-Ub87P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:45 INFO - Running setup.py (path:/tmp/pip-w5mocD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:45 INFO - Running setup.py install for manifestparser 15:20:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozcrash 15:20:45 INFO - Running setup.py install for mozdebug 15:20:45 INFO - Running setup.py install for mozdevice 15:20:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozfile 15:20:45 INFO - Running setup.py install for mozhttpd 15:20:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozinfo 15:20:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozInstall 15:20:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozleak 15:20:46 INFO - Running setup.py install for mozlog 15:20:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for moznetwork 15:20:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozprocess 15:20:46 INFO - Running setup.py install for mozprofile 15:20:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozrunner 15:20:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozscreenshot 15:20:47 INFO - Running setup.py install for moztest 15:20:47 INFO - Running setup.py install for mozversion 15:20:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:47 INFO - Cleaning up... 15:20:47 INFO - Return code: 0 15:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:47 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 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:47 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 15:20:47 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 15:20:47 INFO - Using env: {'DISPLAY': ':0', 15:20:47 INFO - 'HOME': '/home/cltbld', 15:20:47 INFO - 'LANG': 'en_US.UTF-8', 15:20:47 INFO - 'LANGUAGE': 'en_US:en', 15:20:47 INFO - 'LOGNAME': 'cltbld', 15:20:47 INFO - 'MAIL': '/var/mail/cltbld', 15:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:47 INFO - 'MOZ_NO_REMOTE': '1', 15:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:47 INFO - 'NO_EM_RESTART': '1', 15:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:47 INFO - 'PWD': '/builds/slave/test', 15:20:47 INFO - 'SHELL': '/bin/bash', 15:20:47 INFO - 'SHLVL': '1', 15:20:47 INFO - 'TERM': 'linux', 15:20:47 INFO - 'TMOUT': '86400', 15:20:47 INFO - 'USER': 'cltbld', 15:20:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:47 INFO - '_': '/tools/buildbot/bin/python'} 15:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:47 INFO - Running setup.py (path:/tmp/pip-ixPOwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:47 INFO - Running setup.py (path:/tmp/pip-WTLuUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:47 INFO - Running setup.py (path:/tmp/pip-cXGFLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:47 INFO - Running setup.py (path:/tmp/pip-uJ9Irv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:47 INFO - Running setup.py (path:/tmp/pip-r8NPwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:47 INFO - Running setup.py (path:/tmp/pip-0I0V9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:47 INFO - Running setup.py (path:/tmp/pip-0K_o38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:47 INFO - Running setup.py (path:/tmp/pip-sCJKnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:48 INFO - Running setup.py (path:/tmp/pip-TZbJQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:48 INFO - Running setup.py (path:/tmp/pip-JDpXfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:48 INFO - Running setup.py (path:/tmp/pip-XyPYr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:48 INFO - Running setup.py (path:/tmp/pip-CmCAQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:48 INFO - Running setup.py (path:/tmp/pip-F2aIUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:48 INFO - Running setup.py (path:/tmp/pip-yW8ZUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:48 INFO - Running setup.py (path:/tmp/pip-21Z1yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:48 INFO - Running setup.py (path:/tmp/pip-JTGKVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:48 INFO - Running setup.py (path:/tmp/pip-zMigqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:48 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)) 15:20:48 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)) 15:20:48 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)) 15:20:48 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)) 15:20:48 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)) 15:20:48 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)) 15:20:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:50 INFO - Downloading blessings-1.6.tar.gz 15:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:50 INFO - Installing collected packages: blessings 15:20:50 INFO - Running setup.py install for blessings 15:20:50 INFO - Successfully installed blessings 15:20:50 INFO - Cleaning up... 15:20:50 INFO - Return code: 0 15:20:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:51 INFO - Reading from file tmpfile_stdout 15:20:51 INFO - Current package versions: 15:20:51 INFO - argparse == 1.2.1 15:20:51 INFO - blessings == 1.6 15:20:51 INFO - blobuploader == 1.2.4 15:20:51 INFO - docopt == 0.6.1 15:20:51 INFO - manifestparser == 1.1 15:20:51 INFO - mozInstall == 1.12 15:20:51 INFO - mozcrash == 0.17 15:20:51 INFO - mozdebug == 0.1 15:20:51 INFO - mozdevice == 0.48 15:20:51 INFO - mozfile == 1.2 15:20:51 INFO - mozhttpd == 0.7 15:20:51 INFO - mozinfo == 0.9 15:20:51 INFO - mozleak == 0.1 15:20:51 INFO - mozlog == 3.2 15:20:51 INFO - moznetwork == 0.27 15:20:51 INFO - mozprocess == 0.22 15:20:51 INFO - mozprofile == 0.28 15:20:51 INFO - mozrunner == 6.11 15:20:51 INFO - mozscreenshot == 0.1 15:20:51 INFO - mozsystemmonitor == 0.3 15:20:51 INFO - moztest == 0.7 15:20:51 INFO - mozversion == 1.4 15:20:51 INFO - psutil == 3.1.1 15:20:51 INFO - requests == 1.2.3 15:20:51 INFO - wsgiref == 0.1.2 15:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:51 INFO - Using env: {'DISPLAY': ':0', 15:20:51 INFO - 'HOME': '/home/cltbld', 15:20:51 INFO - 'LANG': 'en_US.UTF-8', 15:20:51 INFO - 'LANGUAGE': 'en_US:en', 15:20:51 INFO - 'LOGNAME': 'cltbld', 15:20:51 INFO - 'MAIL': '/var/mail/cltbld', 15:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:51 INFO - 'MOZ_NO_REMOTE': '1', 15:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:51 INFO - 'NO_EM_RESTART': '1', 15:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:51 INFO - 'PWD': '/builds/slave/test', 15:20:51 INFO - 'SHELL': '/bin/bash', 15:20:51 INFO - 'SHLVL': '1', 15:20:51 INFO - 'TERM': 'linux', 15:20:51 INFO - 'TMOUT': '86400', 15:20:51 INFO - 'USER': 'cltbld', 15:20:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:51 INFO - '_': '/tools/buildbot/bin/python'} 15:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 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)) 15:20:51 INFO - Cleaning up... 15:20:51 INFO - Return code: 0 15:20:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20: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', 'jsonschema'] in /builds/slave/test/build 15:20: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 jsonschema 15:20:51 INFO - Using env: {'DISPLAY': ':0', 15:20:51 INFO - 'HOME': '/home/cltbld', 15:20:51 INFO - 'LANG': 'en_US.UTF-8', 15:20:51 INFO - 'LANGUAGE': 'en_US:en', 15:20:51 INFO - 'LOGNAME': 'cltbld', 15:20:51 INFO - 'MAIL': '/var/mail/cltbld', 15:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:51 INFO - 'MOZ_NO_REMOTE': '1', 15:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:51 INFO - 'NO_EM_RESTART': '1', 15:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:51 INFO - 'PWD': '/builds/slave/test', 15:20:51 INFO - 'SHELL': '/bin/bash', 15:20:51 INFO - 'SHLVL': '1', 15:20:51 INFO - 'TERM': 'linux', 15:20:51 INFO - 'TMOUT': '86400', 15:20:51 INFO - 'USER': 'cltbld', 15:20:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:51 INFO - '_': '/tools/buildbot/bin/python'} 15:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:51 INFO - Downloading/unpacking jsonschema 15:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:53 INFO - Downloading/unpacking functools32 (from jsonschema) 15:20:53 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 15:20:53 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 15:20:53 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 15:20:53 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 15:20:53 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 15:20:53 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 15:20:53 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:53 INFO - warning: no files found matching '*.txt' 15:20:53 INFO - no previously-included directories found matching 'build' 15:20:53 INFO - no previously-included directories found matching 'dist' 15:20:53 INFO - no previously-included directories found matching '.git*' 15:20:53 INFO - Installing collected packages: jsonschema, functools32 15:20:53 INFO - Running setup.py install for functools32 15:20:53 INFO - warning: no files found matching '*.txt' 15:20:53 INFO - no previously-included directories found matching 'build' 15:20:53 INFO - no previously-included directories found matching 'dist' 15:20:53 INFO - no previously-included directories found matching '.git*' 15:20:53 INFO - Successfully installed jsonschema functools32 15:20:53 INFO - Cleaning up... 15:20:53 INFO - Return code: 0 15:20:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:20:53 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')]} 15:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:53 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')]} 15:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:53 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 0x7fc6ce0b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1798770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, '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': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', '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 15:20:53 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 15:20:53 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 15:20:53 INFO - Using env: {'DISPLAY': ':0', 15:20:53 INFO - 'HOME': '/home/cltbld', 15:20:53 INFO - 'LANG': 'en_US.UTF-8', 15:20:53 INFO - 'LANGUAGE': 'en_US:en', 15:20:53 INFO - 'LOGNAME': 'cltbld', 15:20:53 INFO - 'MAIL': '/var/mail/cltbld', 15:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:53 INFO - 'MOZ_NO_REMOTE': '1', 15:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:53 INFO - 'NO_EM_RESTART': '1', 15:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:53 INFO - 'PWD': '/builds/slave/test', 15:20:53 INFO - 'SHELL': '/bin/bash', 15:20:53 INFO - 'SHLVL': '1', 15:20:53 INFO - 'TERM': 'linux', 15:20:53 INFO - 'TMOUT': '86400', 15:20:53 INFO - 'USER': 'cltbld', 15:20:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:53 INFO - '_': '/tools/buildbot/bin/python'} 15:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:54 INFO - Downloading/unpacking flake8 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:20:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:20:55 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 15:20:55 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 15:20:55 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 15:20:55 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 15:20:55 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 15:20:55 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 15:20:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:20:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:20:56 INFO - no previously-included directories found matching 'docs/_build' 15:20:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:20:56 INFO - Running setup.py install for pep8 15:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:20:56 INFO - no previously-included directories found matching 'docs/_build' 15:20:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:20:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:20:56 INFO - Cleaning up... 15:20:56 INFO - Return code: 0 15:20:56 INFO - Running post-action listener: _resource_record_post_action 15:20:56 INFO - Running post-action listener: _start_resource_monitoring 15:20:56 INFO - Starting resource monitoring. 15:20:56 INFO - ##### 15:20:56 INFO - ##### Finished create-virtualenv step (success) 15:20:56 INFO - ##### 15:20:56 INFO - ##### 15:20:56 INFO - ##### Running install step. 15:20:56 INFO - ##### 15:20:56 INFO - Running pre-action listener: _resource_record_pre_action 15:20:56 INFO - Running main action method: install 15:20:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:57 INFO - Reading from file tmpfile_stdout 15:20:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:57 INFO - Reading from file tmpfile_stdout 15:20:57 INFO - Output received: 15:20:57 INFO - Usage: mozinstall [options] installer 15:20:57 INFO - Options: 15:20:57 INFO - -h, --help show this help message and exit 15:20:57 INFO - -d DEST, --destination=DEST 15:20:57 INFO - Directory to install application into. [default: 15:20:57 INFO - "/builds/slave/test"] 15:20:57 INFO - --app=APP Application being installed. [default: firefox] 15:20:57 INFO - mkdir: /builds/slave/test/build/application 15:20:57 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'] 15:20:57 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 15:21:13 INFO - Reading from file tmpfile_stdout 15:21:13 INFO - Output received: 15:21:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:21:13 INFO - Running post-action listener: _resource_record_post_action 15:21:13 INFO - ##### 15:21:13 INFO - ##### Finished install step (success) 15:21:13 INFO - ##### 15:21:13 INFO - ##### 15:21:13 INFO - ##### Running run-tests step. 15:21:13 INFO - ##### 15:21:13 INFO - Running pre-action listener: _resource_record_pre_action 15:21:13 INFO - Running main action method: run_tests 15:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:13 INFO - Python 2.7.3 15:21:13 INFO - Return code: 0 15:21:13 INFO - grabbing minidump binary from tooltool 15:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:13 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 0x18279c0>, '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 0x18288c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1828d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:13 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 15:21:13 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 15:21:13 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 15:21:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:13 INFO - Return code: 0 15:21:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:21:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:21:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:21:14 INFO - Return code: 0 15:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:21:14 INFO - Using env: {'DISPLAY': ':0', 15:21:14 INFO - 'HOME': '/home/cltbld', 15:21:14 INFO - 'LANG': 'en_US.UTF-8', 15:21:14 INFO - 'LANGUAGE': 'en_US:en', 15:21:14 INFO - 'LOGNAME': 'cltbld', 15:21:14 INFO - 'MAIL': '/var/mail/cltbld', 15:21:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:14 INFO - 'MOZ_NO_REMOTE': '1', 15:21:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:14 INFO - 'NO_EM_RESTART': '1', 15:21:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:14 INFO - 'PWD': '/builds/slave/test', 15:21:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:14 INFO - 'SHELL': '/bin/bash', 15:21:14 INFO - 'SHLVL': '1', 15:21:14 INFO - 'TERM': 'linux', 15:21:14 INFO - 'TMOUT': '86400', 15:21:14 INFO - 'USER': 'cltbld', 15:21:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463692979.608809-946283170', 15:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:14 INFO - '_': '/tools/buildbot/bin/python'} 15:21:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:21:15 INFO - mozversion application_buildid: 20160519113040 15:21:15 INFO - mozversion application_changeset: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 15:21:15 INFO - mozversion application_display_name: Nightly 15:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:15 INFO - mozversion application_name: Firefox 15:21:15 INFO - mozversion application_remotingname: firefox 15:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:21:15 INFO - mozversion application_vendor: Mozilla 15:21:15 INFO - mozversion application_version: 49.0a1 15:21:15 INFO - mozversion platform_buildid: 20160519113040 15:21:15 INFO - mozversion platform_changeset: a3eb9950fa4bfbdb8d8a84f7b5ba09f6b2e08e35 15:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:21:15 INFO - mozversion platform_version: 49.0a1 15:21:15 INFO - using testdate: 1463696475 15:21:15 INFO - actual date: 1463696475 15:21:15 INFO - starting webserver on 'localhost:60742' 15:21:15 INFO - SUITE-START | Running 2 tests 15:21:15 INFO - TEST-START | dromaeo_css 15:21:15 INFO - operating with platform_type : linux_ 15:21:15 INFO - Initialising browser for dromaeo_css test... 15:21:15 INFO - TEST-INFO | started process 12766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rMWOP/profile http://localhost:60742/getInfo.html) 15:21:19 INFO - PROCESS | 12766 | __metrics Screen width/height:1600/1200 15:21:19 INFO - PROCESS | 12766 | colorDepth:24 15:21:19 INFO - PROCESS | 12766 | Browser inner width/height: 1024/697 15:21:19 INFO - PROCESS | 12766 | __metrics 15:21:20 ERROR - PROCESS | 12766 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:21:21 INFO - TEST-INFO | 12766: exit 0 15:21:21 INFO - Browser initialized. 15:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:21:21 INFO - TEST-INFO | started process 12846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rMWOP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:33 INFO - PROCESS | 12846 | RSS: Main: 153600000 15:21:33 INFO - PROCESS | 12846 | 15:22:24 INFO - PROCESS | 12846 | 1463696544379 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] 15:24:32 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60742/tests/dromaeo/cssquery-ext.html) 15:24:33 INFO - PROCESS | 12846 | RSS: Main: 256049152 15:24:33 INFO - PROCESS | 12846 | 15:27:35 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-ext.html (next: http://localhost:60742/tests/dromaeo/cssquery-jquery.html) 15:27:36 INFO - PROCESS | 12846 | RSS: Main: 232529920 15:27:36 INFO - PROCESS | 12846 | 15:30:38 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60742/tests/dromaeo/cssquery-mootools.html) 15:30:39 INFO - PROCESS | 12846 | RSS: Main: 252510208 15:30:39 INFO - PROCESS | 12846 | 15:33:41 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60742/tests/dromaeo/cssquery-prototype.html) 15:33:41 INFO - PROCESS | 12846 | RSS: Main: 235757568 15:33:41 INFO - PROCESS | 12846 | 15:36:44 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60742/tests/dromaeo/cssquery-yui.html) 15:36:44 INFO - PROCESS | 12846 | RSS: Main: 200544256 15:36:44 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:60742/tests/dromaeo/cssquery-yui.html (next: http://localhost:60742/tests/dromaeo/cssquery-dojo.html) 15:39:47 INFO - PROCESS | 12846 | RSS: Main: 270479360 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | __start_tp_report 15:39:47 INFO - PROCESS | 12846 | _x_x_mozilla_page_load 15:39:47 INFO - PROCESS | 12846 | _x_x_mozilla_page_load_details 15:39:47 INFO - PROCESS | 12846 | |i|pagename|runs| 15:39:47 INFO - PROCESS | 12846 | |0;dojo.html;3106.720395164436;3137.435261652902;3138.058582425272;3139.5290706394053;3160.036188962367;5349.679019258847;5399.62202645815;5425.647332923367;5475.78096876125;5481.506664400198;5463.098588732864;5477.67133971962;5509.146082357241;5592.692401917903;5615.382307946133;4930.186519224333;5015.2226404907115;5026.145555255597;5053.949460505403;5222.791088356461;5078.974605126969;5120.539151476366;5149.433562308143;5160.845174644766;5176.663516871391;4792.065547218293;4831.951680483186;4948.653594248404;4958.330625365584;5002.349694539723;4776.832810851603;4798.904021919542;4865.3675022247235;4871.56155945963;4909.3126962225315;4847.12751704693;4892.706437613754;4898.387701537308;4920.8769780755765;4930.506949305077;5380.7309634518115;5474.124140137559;5510.0632892408385;5549.112142057252;5574.442555744434;5986.97006514969;5999.340072592011;6002.8499287517725;6014.939850601481;6033.396660333975;5789.942100578983;5886.440788125121;5965.701714914237;5969.403059694039;6029.78895738647;5500.312460942382;5572.554195664337;5600.691961942091;5603.943960560383;5631.465010823965;6042.676964465693;6061.511047400019;6070.453659170607;6106.542009349317;6117.816465505953;5581.944180558224;5738.5982981191755;5754.510866576388;5852.707364631751;5874.73563689635;5901.40985901415;5925.170476133345;5926.644401335933;5936.347001829795;5952.255968003999;5847.853803654858;5889.793857214977;5900.822975310747;5904.08486684556;5910.852228694231;5673.8297851064535;5815.447532484407;5878.2358293421585;5884.0585506318785;5905.379935106838;4478.059607482465;4479.641628669699;4481.305397663367;4483;4522.886927826765;3978.562358140602;3989.341758609855;3997.8800635980388;4029;4054.493188351456;5511.889762204813;5573.108302671553;5578.609497335147;5630.042892708249;5631.2397826293745;5982.521398288127;6013.939860601426;6022.488088512438;6023.488003519662;6034.5172386209;5680.5171560417;5681.034224181899;5683.346415162227;5689.260396148474;5699.059655156935;4913.557779799764;4997.9500204997485;5039.168537191323;5043.773030213649;5068.873278168076;6082.787102451393;6087.421694938974;6091.878162436727;6097.451229389376;6101.694915254219;5724.255846739898;5901.940980590311;5908.497777688773;5909.91135132982;5930.555208359304;6043.153958445909;6099.84750381244;6120.387961203844;6120.900429980623;6159;5804.854878628068;5882.5293976482635;5883.0881213411985;5898.085796701518;5901.350851406256;5726.9713651431475;5819.94180058194;5949.494292984971;5975.492083172979;5987.461128498282;5726;5772.278465191851;5772.307323121252;5774.595778295479;5813.069908814569;5650.491455769001;5662.094064949588;5669.149627555899;5676.290463692038;5751.712414379348;5447.972760136174;5611.382747897646;5683.090705487102;5687.630304030225;5696.344920334049;5839.182514447895;5849.94150058494;5854.268216472941;5871.060630299132;5871.735771890189;5675.432456754292;5681.176229446624;5692.089265717631;5692.373838877637;5698.116791897262 15:39:47 INFO - PROCESS | 12846 | |1;ext.html;586.9970650146748;643.8326035230835;644.706658470396;648.730776727658;649.6946435175466;32873.83563082184;42441.78779106104;43349.7832510837;43369.34945975809;48144.51855481453;45469;45726;46112.538874611244;46116;46141.30788038174;8727.738167854974;8895.421797583136;8916;8917.77705557363;8917.866232006525;8643.2653224476;8701.17338852808;8736.475811451333;8753.299736021136;8755.3433492488;8773.956130219372;8813.294936405104;8833.646654133827;8834.337424693142;8842.336824738139;8733.956330218372;8779.64881404743;8801;8809.942806863186;8814.471131732116;8680.913190868137;8755.605997730117;8761.474311541328;8762.948446186434;8781.56092195394;42402.36396454025;42692.359614605804;42773.14453710908;42822.357664635056;42950.35574466385;3498;3660.560732712065;3675.191457879262;3733.21602463483;4100.180380185947;31888.20279493008;32742.345153096805;32989.50515742266;33371.33257334864;33382.49926251108;4321.459817522809;4366.148601022802;4372.103718737683;4430.180416622903;4506.752128632924;368860.15569922247;376046;376213;377596;377939;59451.10823337654;59693.403065968785;59706;59981.40018599758;60303.396966030654;62394;62572.687136564935;62654.686726566986;62674;62764.68617656882;16451.177441127897;16628;16674.916625416794;16702.164891755365;16732;12573.182743121668;12573.308468034164;12595.181313214613;12637.684057898443;12639.11526193176;14969.925150374178;17263.39578114785;17464.738028929576;17481.825181748274;17515;5494.36814766299;5679.602427830012;5692.800751973661;6223.564350495421;6371.916774148406;996.2080146283722;1052.3054783842626;1062.2564205056337;1102.5920409448556;1208.4924331780674;32812.67187328144;33001;33043.173920652174;33592.66407335895;33738.49392259118;1103.6358001859367;1125.0268517732266;1131.3833960491552;1140.0480598700012;1182.869884312725;16662;17317.826821731873;17325.30698772035;17325.306987720604;17415.65168696619;523578;524032;526069;530457;531063;60161.39838601558;60243.69878150669;60265.69867150636;60458.39541604616;60566.394336056954;1290.8580056193812;1376.779715245556;1404.7471455138173;1429.685469196775;1430.0775999480277;32767;33230.83384583062;33519.17384989328;33705.494417583264;34202;50519.49480505148;50925.745371272904;51010.23484647807;51028;51117.74441127771;395026;397156;397243;398164;401677;23596.29211123669;24893.377665558506;28147.296317591405;28239.29401764972;29246.976355827443;47752.28371574359;48481;48991.26513102378;49169.75415122901;49504.75247623739;41465.79267103645;42287.788561057;42797.35803962881;43445.24360683949;45235;42404.57595424006;42611.36082958696;42971.140577188904;43064.56935430731;43332.566674332855;41998.79000604978;42793.57206427896;42993.140137197704;43395.783021085954;43410.131797364505;35873.46189807207;37654;37918.241635167695;38166.63118232217;38500.22999540049;28169.859150704116;28786.424271514872;28908.566371504865;29040;29198 15:39:47 INFO - PROCESS | 12846 | |2;jquery.html;405.6470870342799;406.5994994929994;406.7498488429617;409.2449430800174;421.7743507223634;12682.80975785364;17818;19326.550508711833;19550.90224548877;19616.117274722637;18911.81088189121;19295;19459.610807783836;19659.21363145476;19732.112054957524;5674.460926212014;5797.42025797419;5807.82576522705;5816.069428891378;5846.678432686201;5759.971200143993;5799.681017544033;5839.211706419622;5840.094785308284;5872.060470324749;4161.417401563784;6152.815415537519;6471.223453185625;6486.3513648635235;6626.701798419059;6441.420272175526;6528.902066469007;6537.052127441518;6563.146790917198;6573.276939536647;5657.57568182388;5749.511291540224;5788.363280039192;5798.10129429939;5818.156367326714;19916.80083199164;23442.413939651473;23779.524409511887;23860.88069559641;23967.40081497959;2352.9529409411716;2383.3922349800864;2417.190241269177;2418.818588605862;2543.4404431025146;13743.312834358243;14391.640208994755;14516.491922782652;14916.850831491764;15026.248687565687;1899.7530321058312;1939.4666466721624;1951.756030496188;1966.577185905023;2007.9397618071482;82482;85190;85264;85900;85978.57010714969;10564;10635.255532112833;10799.352038877692;10979.615713449992;11205.271657342246;15309.846901530842;15362.615934601501;15395.153266570222;15443.768343474856;15452.99555528887;7986.7603971880935;8046.919530804734;8076.990376202974;8191;8394;7658.923410765821;7703.3067023968115;7786.727464538714;7790.766277011699;7862.33170180541;6663.000549917454;6810.250872404032;6816.693248803716;6839.2818754031105;6893;1910.8375788057892;1927.6144771045847;1965.6953172258322;1985.3944546913042;2005.8295044921344;954.5942974235921;1032.7108409645311;1039.3504059962524;1045.5869931377063;1085.1210519479248;19231.711524327147;19733.60532789365;19824.4052678417;19924.203031878562;20197.798022019884;1040.8178568750438;1044.6761503933806;1082.8429877667852;1091.47063674118;1117.452448300327;11063.72340691489;11597.942010290064;11620.709482263012;11663.416829158508;11673.76652466946;452809;456586;458072;460603;461533;83622;84811;85564;86142;88657;1036.528379587286;1050.1283934334638;1060.3054998975683;1069.395791377869;1079.4548752879903;17362.47912562625;17535.298588056336;17835.286588536314;17931.37240196587;17980;30911.69088309088;35615;37418.812905935294;40074.59925400709;40222.79888600538;50975;52505.7374713124;52637.7368113157;52896.47103529069;53073;8548.529830859114;8659.437136586102;8770.605322760619;8862.335324850534;9121.863172052557;8601.784955376166;11959.342236177094;13474.52839150625;13744;13824.86175138276;11764.764704706029;12138.878611214128;12181.69545761363;12286.262824230575;12426;11762.58830940913;11832.585859494877;11863.466144023367;12029.15795894279;12180.269183848997;12002.879971200176;12299.446524906221;12389.194702344319;12497.312647804458;12566.434510446868;8661.220490155663;8716.520591367536;8893.955530222307;8951.597178126869;8990.190882820316;11975.76048479008;12028.894943384697;12041.819372709591;12052.397380131133;12283.896250408097 15:39:47 INFO - PROCESS | 12846 | |3;mootools.html;1346.6969931765348;1491.4332553629622;1531.5635044012456;1658.162627872924;1814.7912990006153;8205.138460461647;8529.701460448878;8530.701425450103;8841.38110332277;8857.689980850671;8521.403501754865;8711.390202685814;8735.344849136309;8773.166549177833;8777.692780752675;2023.2412845183057;2265.3430505153488;2315.5021670340916;2343.4844334246523;2344.4490544721975;2335.0543030072763;2359.563480756057;2363.2555744940373;2366.160013195317;2367.7987371073477;2291.7708229177115;2303.401115709919;2338.462153704649;2339.87130707811;2351.5296940611947;2012.456636708088;2191.5726433345503;2255.3459496745922;2256.3569382725846;2268.5576312619046;2308.8845557722047;2309.6997390339316;2334.0430423526273;2334.568104900599;2334.6498025296173;8667.696630617898;8724.171203735636;8734.694285700034;8739.868901966476;8747.737567872973;5024.145895197825;5136.897262054776;5139.408967968657;5142.228665700138;5145.948540514584;3304.7521435892163;3312.867485300585;3367.006733013742;3414.7951122932704;3416.79499230047;1085.4952447112053;1116.7487315354063;1127.5264388956657;1128.9661310160627;1143.645469904324;12183.086268529896;12207.93896030523;12221.572244971383;12237.510499580007;12273.509059637603;4511.909761804811;4526.343680166357;4613.423322084739;4623.976880115645;4625.814967401334;10296.897031029594;10314.1748660107;10319.226058045677;10327.896721032845;10342.896571034344;5231.529162375328;5278.604104692164;5282.339707536558;5286.7092309922555;5289.100852855024;4256.170046840898;4685.1800934836265;4806.49531799163;4814.181589129857;4879.731614761151;3861.4787003754695;3957.703172262034;3985.740926839746;4005.1989602079702;4068.7762173080764;1272.2175861844898;1274.15905502368;1290.2129700882642;1304.1066869194633;1332.5136325241217;1034.5603118674533;1036.1192985962023;1038.631285893512;1050.7005503431485;1058.8200005999;5959.106134079922;6122.6326420414025;6136.325004249529;6177.227846519185;6203.100550420254;430.2191522386858;431.424048894729;432.7273817494958;435.69283655023133;446.38176126064985;4281.892952676146;4299.720518166309;4333.43665323506;4335.7615331157085;4345.065810850682;10200.795984080276;10635.361878287327;10673.679789606324;10692.251542391958;10726.141908647289;10183;10552.525136368882;10609.893901061045;10616.734581635366;10664.306820056672;7667.079950405987;7945.8410831781885;8016.55908925003;8033.437659363905;8046.155153708776;5940.673262970578;6179.567430280017;6197.256329240339;6275.717592708248;6349.9682501587195;9829.361091529028;10090.949545252226;10178.083972442515;10202.642907498499;10260.846087308846;10224.897751022692;10291;10388.844167337345;10389.9480502597;10409.635662751767;7840.137584865546;7871;7985.480943738638;8049.2755651989255;8064.5967701615855;8352.832943340978;8408.453450525696;8434.578271086299;8439.535825529654;8480.491170529787;7364;7720.613969301625;7799.961000194962;7866.213378662088;7898;7664.233576642291;7681.462297639112;7736.303732664087;7837.725679601187;7850.214978502333;6714.697838597177;6850.349216824394;6905.482088843256;6923.9653801730665;6945.895811562932;5102.821401250939;5216.139337009351;5314.62797604164;5356.57147428197;5469.124940009579;5135.101357262539;5150.562202212854;5225.451327610698;5402.162664786807;5426.647267927572 15:39:47 INFO - PROCESS | 12846 | |4;prototype.html;323.41461953863507;334.6101791413004;339.6467673619436;340.5011657921145;340.86024729860765;5285.735713214338;5327.733613319338;5337.973310133453;5357.383900851399;5369.731513424333;5001.924971125427;5123;5239.685618862862;5273.683578985264;5280.551153151977;4157.979210103946;4215.3044747616605;4216.7680777557225;4224.387463817745;4227.746335219881;4194.370844373338;4215.683823713219;4218.599233072853;4218.599233072869;4228.873133805991;4000.919521848637;4023.718339716221;4185.100203456256;4197.160567886435;4198;4137.462129923121;4140.482439695038;4160.105577300879;4175.958240417603;4186.497620285585;3700.204456041937;3707.3141468828353;3710.350688629479;3720.516332876709;3740.869069582579;5018.573421259197;5127.154019586764;5130.51260130287;5138.845834624967;5157.742112894341;4789.185838407479;4807.259861878731;4812.8796780080775;4832.613390928717;4836.347093142416;5524.817697009699;5565.777368905279;5578;5581.0512212923495;5588.692621905793;3929.528456585228;4097.795110244506;4102.343625020012;4111.773852438115;4111.951452379654;5716.971415142939;5741.684207368593;5749.885002299972;5776.768929242825;5780.595358324919;4171.874843754692;4181.456410666594;4197.160567886435;4198.874033778991;4208.179405015992;3859;4091.2022155679356;4108.958910410857;4243.893902652459;4251.511076226212;4663.650226233046;4676.672632915731;4677.532246775295;4706.505816889246;4708.152532544175;5552.91670624941;5571.554275657938;5583.330000399897;5593.860153496195;5602.663840169603;1385.6189547874415;1416.2564653556965;1433.677422579911;1440.1431148466854;1442.935067921946;902.6930843513237;903.3270213690711;903.9050899655441;908.7773495493515;911.0980129671577;4730.448329064271;4857.684250523705;4927.926081108786;4933.9013219736125;4952.356193694796;5043.125418511413;5085.618578606619;5106.017306500935;5179;5179.860430705239;4788.826737449278;4794.250098713945;4819.59033482158;4935.851924442272;5061.2661164131;3039.2098054505987;3046.1014000869795;3068.815871047744;3070.3091804343844;3098.597182366323;5955.553333500005;5959.821205363759;5966.791162309299;6005.519558435315;6020.849478762978;5503.862403439946;5770.769169233267;5795.391483894215;5803.7968671096305;5819.214406055213;5827.941720582825;5864.736086876101;5867.853303667357;5914.378990206139;5927.614705044159;5589.357223919302;5619.661321744277;5741.770329186953;5742.799002034909;5763.769449222152;5630.380658127521;5646.209530665628;5652.604317697722;5682.89732798867;5693.629914055573;5774.509166720875;5909.468147866541;5915.201447804663;5915.467607915309;5939.683523425953;3994.6604538614542;4029.6023865799802;4120.299549076724;4128.649064829523;4133.834646614102;5662.518685911744;5690.886182276248;5709.885802283848;5733.885322293448;5753.1945527627;5540.753330500766;5556.249906262603;5574.609777315549;5575.219469274224;5576.972115139399;5347.224652425299;5523.944760552343;5561.833145005657;5575.386707462257;5581.934684166884;5447.073997420527;5471.699056551928;5493.066178749542;5518.420565840529;5535.5848311376;5498.202760599611;5594.41258667834;5651.547876169979;5654.3497497788285;5655;5530.336359636869;5547.694876781654;5548.889022219614;5552.611317207757;5563.610547261653 15:39:47 INFO - PROCESS | 12846 | |5;yui.html;678.6606696651675;698.0262533765398;760.8097975506123;824.7731873734723;868.9695860644877;14230.715385692292;15024.624384390381;15228.695426091472;15330.923345383257;15342.693146137099;13975.301234938262;14021;14076.507322243699;14094.718105637907;14109.858901410982;674.9561278516893;792.053496072194;796.8924195233657;815.9714409995652;817.3052905030736;780.3601047141346;784.0943710014942;784.1883650421814;789.7038610521055;798.2576204130156;843.2621456225802;844.6832437835811;845.9280961118312;845.9873101903477;846.4751853850621;709.2977951827705;837.4305472278847;848.516345682961;852.5694524265268;856.3235044315015;628.1143587541544;629.5341447328989;630.5869655375736;630.782380078872;630.9085182648536;14075.366608502642;14079.0848594841;14084.92957535216;14100.153990760587;14101.64745881351;13872;13995.440182392693;14006.649833754136;14049.297535123203;14055;11883.702907427383;11906.88093119075;11970.491070319611;12082.33547154906;12134.332611706353;4473.932891006638;4519.548045195487;4554;4637.768111594441;4700.976495117503;58401.70799146019;58843.705781471246;58889.41110588925;58988;59148.70425647887;10263.640772572924;10353.43056131905;10804.891951080546;10839.83740243897;10950.288231264942;20226.39320820378;20227.19091236334;20376.388708338774;20409.183632654825;20419.4895127623;8013.7996550085545;8059.314958228499;8238.382121340923;8343.624536895853;8345.082040975487;4630.166570017362;4687.484376718558;4694.248920172756;4697.060587882437;4702.952970470252;3258.7067163955358;3324.484704870749;3337.0823023668686;3345.1971526833386;3353.899383018513;529.6742503360406;620.0358442621766;633.5027003801994;637.4677144584232;640.1709785827271;733.0726630812027;752.1087511299128;768.6886810841618;783.122902349361;807.983840323202;9968.700938971842;10061.54723037465;10304.896951030394;10553.788924221626;10599.258051936291;631.6052467207995;736.7582636399883;751.1549506804845;761.7636161541311;807.4065561812064;4537.160625284333;4852.199387101159;4886.438059623118;4889.706617602955;5085.186370180827;76859.61570192114;77436;77876.61061694655;78239;78242.77802724189;66620;67046.32953670499;67757.66121169363;70355.64822175959;70678.29321706717;61033.37082864642;61391.693041534505;62115;62247.377526225064;62352.688236558526;9594.520273986132;9677.854832177663;9699.5150242489;9716.076972687584;9766.36518626287;38685.419718704805;39456;39562.40656390214;40258.1948361037;40599.59400405958;49386.50613493963;52635.73682131565;54952.17571736347;55777;56039;12214.511419543118;12268.263904165779;12403.379831008593;12435.813462798245;12451;13636.181829090287;13668.453261869414;13834.100783449043;13882.444702211798;14200.289985500476;13007.869921300666;13381.19712817234;13421.32893355348;13435.3334927088;13490.190588564717;12727;13035.087543872218;13440.865591343962;13542.322883855964;13575.32123393846;12290.692732681755;12304.753904921672;12461.563845265735;12549.808694962805;12836.294003829878;9677.580604848788;9779.951100244738;10254.128399086161;10308.793824123326;10349.223808214263;9862.309638325536;10230.6419275325;10242.129418999171;10245.538950747085;10276.845847312446 15:39:47 INFO - PROCESS | 12846 | __end_tp_report 15:39:47 INFO - PROCESS | 12846 | __start_cc_report 15:39:47 INFO - PROCESS | 12846 | _x_x_mozilla_cycle_collect,909 15:39:47 INFO - PROCESS | 12846 | __end_cc_report 15:39:47 INFO - PROCESS | 12846 | __startTimestamp1463697587807__endTimestamp 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | ------- Summary: start ------- 15:39:47 INFO - PROCESS | 12846 | Number of tests: 6 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#0] dojo.html Cycles:165 Average:5475.78 Median:5683.09 stddev:645.69 (11.4%) stddev-sans-first:620.35 15:39:47 INFO - PROCESS | 12846 | Values: 3106.7 3137.4 3138.1 3139.5 3160.0 5349.7 5399.6 5425.6 5475.8 5481.5 5463.1 5477.7 5509.1 5592.7 5615.4 4930.2 5015.2 5026.1 5053.9 5222.8 5079.0 5120.5 5149.4 5160.8 5176.7 4792.1 4832.0 4948.7 4958.3 5002.3 4776.8 4798.9 4865.4 4871.6 4909.3 4847.1 4892.7 4898.4 4920.9 4930.5 5380.7 5474.1 5510.1 5549.1 5574.4 5987.0 5999.3 6002.8 6014.9 6033.4 5789.9 5886.4 5965.7 5969.4 6029.8 5500.3 5572.6 5600.7 5603.9 5631.5 6042.7 6061.5 6070.5 6106.5 6117.8 5581.9 5738.6 5754.5 5852.7 5874.7 5901.4 5925.2 5926.6 5936.3 5952.3 5847.9 5889.8 5900.8 5904.1 5910.9 5673.8 5815.4 5878.2 5884.1 5905.4 4478.1 4479.6 4481.3 4483.0 4522.9 3978.6 3989.3 3997.9 4029.0 4054.5 5511.9 5573.1 5578.6 5630.0 5631.2 5982.5 6013.9 6022.5 6023.5 6034.5 5680.5 5681.0 5683.3 5689.3 5699.1 4913.6 4998.0 5039.2 5043.8 5068.9 6082.8 6087.4 6091.9 6097.5 6101.7 5724.3 5901.9 5908.5 5909.9 5930.6 6043.2 6099.8 6120.4 6120.9 6159.0 5804.9 5882.5 5883.1 5898.1 5901.4 5727.0 5819.9 5949.5 5975.5 5987.5 5726.0 5772.3 5772.3 5774.6 5813.1 5650.5 5662.1 5669.1 5676.3 5751.7 5448.0 5611.4 5683.1 5687.6 5696.3 5839.2 5849.9 5854.3 5871.1 5871.7 5675.4 5681.2 5692.1 5692.4 5698.1 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#1] ext.html Cycles:180 Average:60019.19 Median:42809.86 stddev:116082.03 (271.2%) stddev-sans-first:116321.91 15:39:47 INFO - PROCESS | 12846 | Values: 587.0 643.8 644.7 648.7 649.7 32873.8 42441.8 43349.8 43369.3 48144.5 45469.0 45726.0 46112.5 46116.0 46141.3 8727.7 8895.4 8916.0 8917.8 8917.9 8643.3 8701.2 8736.5 8753.3 8755.3 8774.0 8813.3 8833.6 8834.3 8842.3 8734.0 8779.6 8801.0 8809.9 8814.5 8680.9 8755.6 8761.5 8762.9 8781.6 42402.4 42692.4 42773.1 42822.4 42950.4 3498.0 3660.6 3675.2 3733.2 4100.2 31888.2 32742.3 32989.5 33371.3 33382.5 4321.5 4366.1 4372.1 4430.2 4506.8 368860.2 376046.0 376213.0 377596.0 377939.0 59451.1 59693.4 59706.0 59981.4 60303.4 62394.0 62572.7 62654.7 62674.0 62764.7 16451.2 16628.0 16674.9 16702.2 16732.0 12573.2 12573.3 12595.2 12637.7 12639.1 14969.9 17263.4 17464.7 17481.8 17515.0 5494.4 5679.6 5692.8 6223.6 6371.9 996.2 1052.3 1062.3 1102.6 1208.5 32812.7 33001.0 33043.2 33592.7 33738.5 1103.6 1125.0 1131.4 1140.0 1182.9 16662.0 17317.8 17325.3 17325.3 17415.7 523578.0 524032.0 526069.0 530457.0 531063.0 60161.4 60243.7 60265.7 60458.4 60566.4 1290.9 1376.8 1404.7 1429.7 1430.1 32767.0 33230.8 33519.2 33705.5 34202.0 50519.5 50925.7 51010.2 51028.0 51117.7 395026.0 397156.0 397243.0 398164.0 401677.0 23596.3 24893.4 28147.3 28239.3 29247.0 47752.3 48481.0 48991.3 49169.8 49504.8 41465.8 42287.8 42797.4 43445.2 45235.0 42404.6 42611.4 42971.1 43064.6 43332.6 41998.8 42793.6 42993.1 43395.8 43410.1 35873.5 37654.0 37918.2 38166.6 38500.2 28169.9 28786.4 28908.6 29040.0 29198.0 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#2] jquery.html Cycles:180 Average:28024.17 Median:13066.24 stddev:75492.67 (577.8%) stddev-sans-first:75675.97 15:39:47 INFO - PROCESS | 12846 | Values: 405.6 406.6 406.7 409.2 421.8 12682.8 17818.0 19326.6 19550.9 19616.1 18911.8 19295.0 19459.6 19659.2 19732.1 5674.5 5797.4 5807.8 5816.1 5846.7 5760.0 5799.7 5839.2 5840.1 5872.1 4161.4 6152.8 6471.2 6486.4 6626.7 6441.4 6528.9 6537.1 6563.1 6573.3 5657.6 5749.5 5788.4 5798.1 5818.2 19916.8 23442.4 23779.5 23860.9 23967.4 2353.0 2383.4 2417.2 2418.8 2543.4 13743.3 14391.6 14516.5 14916.9 15026.2 1899.8 1939.5 1951.8 1966.6 2007.9 82482.0 85190.0 85264.0 85900.0 85978.6 10564.0 10635.3 10799.4 10979.6 11205.3 15309.8 15362.6 15395.2 15443.8 15453.0 7986.8 8046.9 8077.0 8191.0 8394.0 7658.9 7703.3 7786.7 7790.8 7862.3 6663.0 6810.3 6816.7 6839.3 6893.0 1910.8 1927.6 1965.7 1985.4 2005.8 954.6 1032.7 1039.4 1045.6 1085.1 19231.7 19733.6 19824.4 19924.2 20197.8 1040.8 1044.7 1082.8 1091.5 1117.5 11063.7 11597.9 11620.7 11663.4 11673.8 452809.0 456586.0 458072.0 460603.0 461533.0 83622.0 84811.0 85564.0 86142.0 88657.0 1036.5 1050.1 1060.3 1069.4 1079.5 17362.5 17535.3 17835.3 17931.4 17980.0 30911.7 35615.0 37418.8 40074.6 40222.8 50975.0 52505.7 52637.7 52896.5 53073.0 8548.5 8659.4 8770.6 8862.3 9121.9 8601.8 11959.3 13474.5 13744.0 13824.9 11764.8 12138.9 12181.7 12286.3 12426.0 11762.6 11832.6 11863.5 12029.2 12180.3 12002.9 12299.4 12389.2 12497.3 12566.4 8661.2 8716.5 8894.0 8951.6 8990.2 11975.8 12028.9 12041.8 12052.4 12283.9 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#3] mootools.html Cycles:180 Average:5775.55 Median:4334.60 stddev:3278.94 (75.6%) stddev-sans-first:3271.24 15:39:47 INFO - PROCESS | 12846 | Values: 1346.7 1491.4 1531.6 1658.2 1814.8 8205.1 8529.7 8530.7 8841.4 8857.7 8521.4 8711.4 8735.3 8773.2 8777.7 2023.2 2265.3 2315.5 2343.5 2344.4 2335.1 2359.6 2363.3 2366.2 2367.8 2291.8 2303.4 2338.5 2339.9 2351.5 2012.5 2191.6 2255.3 2256.4 2268.6 2308.9 2309.7 2334.0 2334.6 2334.6 8667.7 8724.2 8734.7 8739.9 8747.7 5024.1 5136.9 5139.4 5142.2 5145.9 3304.8 3312.9 3367.0 3414.8 3416.8 1085.5 1116.7 1127.5 1129.0 1143.6 12183.1 12207.9 12221.6 12237.5 12273.5 4511.9 4526.3 4613.4 4624.0 4625.8 10296.9 10314.2 10319.2 10327.9 10342.9 5231.5 5278.6 5282.3 5286.7 5289.1 4256.2 4685.2 4806.5 4814.2 4879.7 3861.5 3957.7 3985.7 4005.2 4068.8 1272.2 1274.2 1290.2 1304.1 1332.5 1034.6 1036.1 1038.6 1050.7 1058.8 5959.1 6122.6 6136.3 6177.2 6203.1 430.2 431.4 432.7 435.7 446.4 4281.9 4299.7 4333.4 4335.8 4345.1 10200.8 10635.4 10673.7 10692.3 10726.1 10183.0 10552.5 10609.9 10616.7 10664.3 7667.1 7945.8 8016.6 8033.4 8046.2 5940.7 6179.6 6197.3 6275.7 6350.0 9829.4 10090.9 10178.1 10202.6 10260.8 10224.9 10291.0 10388.8 10389.9 10409.6 7840.1 7871.0 7985.5 8049.3 8064.6 8352.8 8408.5 8434.6 8439.5 8480.5 7364.0 7720.6 7800.0 7866.2 7898.0 7664.2 7681.5 7736.3 7837.7 7850.2 6714.7 6850.3 6905.5 6924.0 6945.9 5102.8 5216.1 5314.6 5356.6 5469.1 5135.1 5150.6 5225.5 5402.2 5426.6 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#4] prototype.html Cycles:180 Average:4661.44 Median:5179.43 stddev:1359.07 (26.2%) stddev-sans-first:1323.31 15:39:47 INFO - PROCESS | 12846 | Values: 323.4 334.6 339.6 340.5 340.9 5285.7 5327.7 5338.0 5357.4 5369.7 5001.9 5123.0 5239.7 5273.7 5280.6 4158.0 4215.3 4216.8 4224.4 4227.7 4194.4 4215.7 4218.6 4218.6 4228.9 4000.9 4023.7 4185.1 4197.2 4198.0 4137.5 4140.5 4160.1 4176.0 4186.5 3700.2 3707.3 3710.4 3720.5 3740.9 5018.6 5127.2 5130.5 5138.8 5157.7 4789.2 4807.3 4812.9 4832.6 4836.3 5524.8 5565.8 5578.0 5581.1 5588.7 3929.5 4097.8 4102.3 4111.8 4112.0 5717.0 5741.7 5749.9 5776.8 5780.6 4171.9 4181.5 4197.2 4198.9 4208.2 3859.0 4091.2 4109.0 4243.9 4251.5 4663.7 4676.7 4677.5 4706.5 4708.2 5552.9 5571.6 5583.3 5593.9 5602.7 1385.6 1416.3 1433.7 1440.1 1442.9 902.7 903.3 903.9 908.8 911.1 4730.4 4857.7 4927.9 4933.9 4952.4 5043.1 5085.6 5106.0 5179.0 5179.9 4788.8 4794.3 4819.6 4935.9 5061.3 3039.2 3046.1 3068.8 3070.3 3098.6 5955.6 5959.8 5966.8 6005.5 6020.8 5503.9 5770.8 5795.4 5803.8 5819.2 5827.9 5864.7 5867.9 5914.4 5927.6 5589.4 5619.7 5741.8 5742.8 5763.8 5630.4 5646.2 5652.6 5682.9 5693.6 5774.5 5909.5 5915.2 5915.5 5939.7 3994.7 4029.6 4120.3 4128.6 4133.8 5662.5 5690.9 5709.9 5733.9 5753.2 5540.8 5556.2 5574.6 5575.2 5577.0 5347.2 5523.9 5561.8 5575.4 5581.9 5447.1 5471.7 5493.1 5518.4 5535.6 5498.2 5594.4 5651.5 5654.3 5655.0 5530.3 5547.7 5548.9 5552.6 5563.6 15:39:47 INFO - PROCESS | 12846 | 15:39:47 INFO - PROCESS | 12846 | [#5] yui.html Cycles:180 Average:16623.06 Median:4701.96 stddev:20772.32 (441.8%) stddev-sans-first:20796.08 15:39:47 INFO - PROCESS | 12846 | Values: 678.7 698.0 760.8 824.8 869.0 14230.7 15024.6 15228.7 15330.9 15342.7 13975.3 14021.0 14076.5 14094.7 14109.9 675.0 792.1 796.9 816.0 817.3 780.4 784.1 784.2 789.7 798.3 843.3 844.7 845.9 846.0 846.5 709.3 837.4 848.5 852.6 856.3 628.1 629.5 630.6 630.8 630.9 14075.4 14079.1 14084.9 14100.2 14101.6 13872.0 13995.4 14006.6 14049.3 14055.0 11883.7 11906.9 11970.5 12082.3 12134.3 4473.9 4519.5 4554.0 4637.8 4701.0 58401.7 58843.7 58889.4 58988.0 59148.7 10263.6 10353.4 10804.9 10839.8 10950.3 20226.4 20227.2 20376.4 20409.2 20419.5 8013.8 8059.3 8238.4 8343.6 8345.1 4630.2 4687.5 4694.2 4697.1 4703.0 3258.7 3324.5 3337.1 3345.2 3353.9 529.7 620.0 633.5 637.5 640.2 733.1 752.1 768.7 783.1 808.0 9968.7 10061.5 10304.9 10553.8 10599.3 631.6 736.8 751.2 761.8 807.4 4537.2 4852.2 4886.4 4889.7 5085.2 76859.6 77436.0 77876.6 78239.0 78242.8 66620.0 67046.3 67757.7 70355.6 70678.3 61033.4 61391.7 62115.0 62247.4 62352.7 9594.5 9677.9 9699.5 9716.1 9766.4 38685.4 39456.0 39562.4 40258.2 40599.6 49386.5 52635.7 54952.2 55777.0 56039.0 12214.5 12268.3 12403.4 12435.8 12451.0 13636.2 13668.5 13834.1 13882.4 14200.3 13007.9 13381.2 13421.3 13435.3 13490.2 12727.0 13035.1 13440.9 13542.3 13575.3 12290.7 12304.8 12461.6 12549.8 12836.3 9677.6 9780.0 10254.1 10308.8 10349.2 9862.3 10230.6 10242.1 10245.5 10276.8 15:39:47 INFO - PROCESS | 12846 | -------- Summary: end -------- 15:39:47 INFO - PROCESS | 12846 | 15:39:48 INFO - TEST-INFO | 12846: exit 0 15:39:48 INFO - TEST-OK | dromaeo_css | took 1113423ms 15:39:48 INFO - TEST-START | kraken 15:39:48 INFO - operating with platform_type : linux_ 15:39:48 INFO - Initialising browser for kraken test... 15:39:48 INFO - TEST-INFO | started process 13026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp8TUu/profile http://localhost:60742/getInfo.html) 15:39:52 INFO - PROCESS | 13026 | __metrics Screen width/height:1600/1200 15:39:52 INFO - PROCESS | 13026 | colorDepth:24 15:39:52 INFO - PROCESS | 13026 | Browser inner width/height: 1024/697 15:39:52 INFO - PROCESS | 13026 | __metrics 15:39:53 ERROR - PROCESS | 13026 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:39:54 INFO - TEST-INFO | 13026: exit 0 15:39:54 INFO - Browser initialized. 15:39:54 INFO - Running cycle 1/1 for kraken test... 15:39:54 INFO - TEST-INFO | started process 13107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp8TUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:06 INFO - PROCESS | 13107 | RSS: Main: 153415680 15:40:06 INFO - PROCESS | 13107 | 15:40:09 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60742/tests/kraken/driver.html?testName=audio-beat-detection) 15:40:09 INFO - PROCESS | 13107 | RSS: Main: 209481728 15:40:09 INFO - PROCESS | 13107 | 15:40:12 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60742/tests/kraken/driver.html?testName=audio-dft) 15:40:13 INFO - PROCESS | 13107 | RSS: Main: 197406720 15:40:13 INFO - PROCESS | 13107 | 15:40:16 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60742/tests/kraken/driver.html?testName=audio-fft) 15:40:17 INFO - PROCESS | 13107 | RSS: Main: 265224192 15:40:17 INFO - PROCESS | 13107 | 15:40:19 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60742/tests/kraken/driver.html?testName=audio-oscillator) 15:40:19 INFO - PROCESS | 13107 | RSS: Main: 174854144 15:40:19 INFO - PROCESS | 13107 | 15:40:22 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:40:22 INFO - PROCESS | 13107 | RSS: Main: 179294208 15:40:22 INFO - PROCESS | 13107 | 15:40:25 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60742/tests/kraken/driver.html?testName=imaging-darkroom) 15:40:26 INFO - PROCESS | 13107 | RSS: Main: 214544384 15:40:26 INFO - PROCESS | 13107 | 15:40:30 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60742/tests/kraken/driver.html?testName=imaging-desaturate) 15:40:30 INFO - PROCESS | 13107 | RSS: Main: 213135360 15:40:30 INFO - PROCESS | 13107 | 15:40:33 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60742/tests/kraken/driver.html?testName=json-parse-financial) 15:40:34 INFO - PROCESS | 13107 | RSS: Main: 213917696 15:40:34 INFO - PROCESS | 13107 | 15:40:35 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:40:36 INFO - PROCESS | 13107 | RSS: Main: 203046912 15:40:36 INFO - PROCESS | 13107 | 15:40:38 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:39 INFO - PROCESS | 13107 | RSS: Main: 205475840 15:40:39 INFO - PROCESS | 13107 | 15:40:41 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:41 INFO - PROCESS | 13107 | RSS: Main: 217108480 15:40:41 INFO - PROCESS | 13107 | 15:40:44 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:45 INFO - PROCESS | 13107 | RSS: Main: 223391744 15:40:45 INFO - PROCESS | 13107 | 15:40:47 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:48 INFO - PROCESS | 13107 | RSS: Main: 221343744 15:40:48 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:60742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60742/tests/kraken/driver.html?testName=ai-astar) 15:40:50 INFO - PROCESS | 13107 | RSS: Main: 266833920 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | __start_tp_report 15:40:50 INFO - PROCESS | 13107 | _x_x_mozilla_page_load 15:40:50 INFO - PROCESS | 13107 | _x_x_mozilla_page_load_details 15:40:50 INFO - PROCESS | 13107 | |i|pagename|runs| 15:40:50 INFO - PROCESS | 13107 | |0;ai-astar;109;105;111;109;110;110;109;110;109;108 15:40:50 INFO - PROCESS | 13107 | |1;audio-beat-detection;157;125;150;207;133;161;152;125;177;123 15:40:50 INFO - PROCESS | 13107 | |2;audio-dft;161;161;161;162;163;162;164;163;165;161 15:40:50 INFO - PROCESS | 13107 | |3;audio-fft;74;76;75;151;76;74;76;73;134;75 15:40:50 INFO - PROCESS | 13107 | |4;audio-oscillator;95;93;152;92;92;92;123;93;93;129 15:40:50 INFO - PROCESS | 13107 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;119;117 15:40:50 INFO - PROCESS | 13107 | |6;imaging-darkroom;146;146;145;145;145;145;146;146;146;147 15:40:50 INFO - PROCESS | 13107 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 15:40:50 INFO - PROCESS | 13107 | |8;json-parse-financial;54;65;55;55;54;55;56;107;52;52 15:40:50 INFO - PROCESS | 13107 | |9;json-stringify-tinderbox;61;63;63;62;63;62;62;63;62;64 15:40:50 INFO - PROCESS | 13107 | |10;stanford-crypto-aes;88;79;83;79;80;79;81;80;81;81 15:40:50 INFO - PROCESS | 13107 | |11;stanford-crypto-ccm;132;125;123;127;116;127;117;120;191;126 15:40:50 INFO - PROCESS | 13107 | |12;stanford-crypto-pbkdf2;167;159;163;164;166;162;163;159;158;162 15:40:50 INFO - PROCESS | 13107 | |13;stanford-crypto-sha256-iterative;66;63;64;64;62;61;63;62;62;62 15:40:50 INFO - PROCESS | 13107 | __end_tp_report 15:40:50 INFO - PROCESS | 13107 | __start_cc_report 15:40:50 INFO - PROCESS | 13107 | _x_x_mozilla_cycle_collect,1874 15:40:50 INFO - PROCESS | 13107 | __end_cc_report 15:40:50 INFO - PROCESS | 13107 | __startTimestamp1463697650433__endTimestamp 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | ------- Summary: start ------- 15:40:50 INFO - PROCESS | 13107 | Number of tests: 14 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.63 (1.5%) stddev-sans-first:1.73 15:40:50 INFO - PROCESS | 13107 | Values: 109.0 105.0 111.0 109.0 110.0 110.0 109.0 110.0 109.0 108.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:154.50 stddev:26.69 (17.3%) stddev-sans-first:28.22 15:40:50 INFO - PROCESS | 13107 | Values: 157.0 125.0 150.0 207.0 133.0 161.0 152.0 125.0 177.0 123.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.42 (0.9%) stddev-sans-first:1.42 15:40:50 INFO - PROCESS | 13107 | Values: 161.0 161.0 161.0 162.0 163.0 162.0 164.0 163.0 165.0 161.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#3] audio-fft Cycles:10 Average:88.40 Median:75.00 stddev:28.81 (38.4%) stddev-sans-first:30.08 15:40:50 INFO - PROCESS | 13107 | Values: 74.0 76.0 75.0 151.0 76.0 74.0 76.0 73.0 134.0 75.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.50 stddev:21.46 (23.2%) stddev-sans-first:22.43 15:40:50 INFO - PROCESS | 13107 | Values: 95.0 93.0 152.0 92.0 92.0 92.0 123.0 93.0 93.0 129.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 15:40:50 INFO - PROCESS | 13107 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 119.0 117.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:40:50 INFO - PROCESS | 13107 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 147.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:40:50 INFO - PROCESS | 13107 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:55.00 stddev:16.74 (30.4%) stddev-sans-first:17.59 15:40:50 INFO - PROCESS | 13107 | Values: 54.0 65.0 55.0 55.0 54.0 55.0 56.0 107.0 52.0 52.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 15:40:50 INFO - PROCESS | 13107 | Values: 61.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 62.0 64.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.73 (3.4%) stddev-sans-first:1.32 15:40:50 INFO - PROCESS | 13107 | Values: 88.0 79.0 83.0 79.0 80.0 79.0 81.0 80.0 81.0 81.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:126.50 stddev:21.85 (17.3%) stddev-sans-first:23.17 15:40:50 INFO - PROCESS | 13107 | Values: 132.0 125.0 123.0 127.0 116.0 127.0 117.0 120.0 191.0 126.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:2.98 (1.8%) stddev-sans-first:2.64 15:40:50 INFO - PROCESS | 13107 | Values: 167.0 159.0 163.0 164.0 166.0 162.0 163.0 159.0 158.0 162.0 15:40:50 INFO - PROCESS | 13107 | 15:40:50 INFO - PROCESS | 13107 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.01 15:40:50 INFO - PROCESS | 13107 | Values: 66.0 63.0 64.0 64.0 62.0 61.0 63.0 62.0 62.0 62.0 15:40:50 INFO - PROCESS | 13107 | -------- Summary: end -------- 15:40:50 INFO - PROCESS | 13107 | 15:40:51 INFO - TEST-INFO | 13107: exit 0 15:40:51 INFO - TEST-OK | kraken | took 62852ms 15:40:51 INFO - SUITE-END | took 1176s 15:40:51 INFO - Completed test suite (00:19:36) 15:40:51 INFO - javascript benchmark 15:40:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.720395164436, 3137.435261652902, 3138.058582425272, 3139.5290706394053, 3160.036188962367, 5349.679019258847, 5399.62202645815, 5425.647332923367, 5475.78096876125, 5481.506664400198, 5463.098588732864, 5477.67133971962, 5509.146082357241, 5592.692401917903, 5615.382307946133, 4930.186519224333, 5015.2226404907115, 5026.145555255597, 5053.949460505403, 5222.791088356461, 5078.974605126969, 5120.539151476366, 5149.433562308143, 5160.845174644766, 5176.663516871391, 4792.065547218293, 4831.951680483186, 4948.653594248404, 4958.330625365584, 5002.349694539723, 4776.832810851603, 4798.904021919542, 4865.3675022247235, 4871.56155945963, 4909.3126962225315, 4847.12751704693, 4892.706437613754, 4898.387701537308, 4920.8769780755765, 4930.506949305077, 5380.7309634518115, 5474.124140137559, 5510.0632892408385, 5549.112142057252, 5574.442555744434, 5986.97006514969, 5999.340072592011, 6002.8499287517725, 6014.939850601481, 6033.396660333975, 5789.942100578983, 5886.440788125121, 5965.701714914237, 5969.403059694039, 6029.78895738647, 5500.312460942382, 5572.554195664337, 5600.691961942091, 5603.943960560383, 5631.465010823965, 6042.676964465693, 6061.511047400019, 6070.453659170607, 6106.542009349317, 6117.816465505953, 5581.944180558224, 5738.5982981191755, 5754.510866576388, 5852.707364631751, 5874.73563689635, 5901.40985901415, 5925.170476133345, 5926.644401335933, 5936.347001829795, 5952.255968003999, 5847.853803654858, 5889.793857214977, 5900.822975310747, 5904.08486684556, 5910.852228694231, 5673.8297851064535, 5815.447532484407, 5878.2358293421585, 5884.0585506318785, 5905.379935106838, 4478.059607482465, 4479.641628669699, 4481.305397663367, 4483.0, 4522.886927826765, 3978.562358140602, 3989.341758609855, 3997.8800635980388, 4029.0, 4054.493188351456, 5511.889762204813, 5573.108302671553, 5578.609497335147, 5630.042892708249, 5631.2397826293745, 5982.521398288127, 6013.939860601426, 6022.488088512438, 6023.488003519662, 6034.5172386209, 5680.5171560417, 5681.034224181899, 5683.346415162227, 5689.260396148474, 5699.059655156935, 4913.557779799764, 4997.9500204997485, 5039.168537191323, 5043.773030213649, 5068.873278168076, 6082.787102451393, 6087.421694938974, 6091.878162436727, 6097.451229389376, 6101.694915254219, 5724.255846739898, 5901.940980590311, 5908.497777688773, 5909.91135132982, 5930.555208359304, 6043.153958445909, 6099.84750381244, 6120.387961203844, 6120.900429980623, 6159.0, 5804.854878628068, 5882.5293976482635, 5883.0881213411985, 5898.085796701518, 5901.350851406256, 5726.9713651431475, 5819.94180058194, 5949.494292984971, 5975.492083172979, 5987.461128498282, 5726.0, 5772.278465191851, 5772.307323121252, 5774.595778295479, 5813.069908814569, 5650.491455769001, 5662.094064949588, 5669.149627555899, 5676.290463692038, 5751.712414379348, 5447.972760136174, 5611.382747897646, 5683.090705487102, 5687.630304030225, 5696.344920334049, 5839.182514447895, 5849.94150058494, 5854.268216472941, 5871.060630299132, 5871.735771890189, 5675.432456754292, 5681.176229446624, 5692.089265717631, 5692.373838877637, 5698.116791897262], "value": 5430.471127551981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.9970650146748, 643.8326035230835, 644.706658470396, 648.730776727658, 649.6946435175466, 32873.83563082184, 42441.78779106104, 43349.7832510837, 43369.34945975809, 48144.51855481453, 45469.0, 45726.0, 46112.538874611244, 46116.0, 46141.30788038174, 8727.738167854974, 8895.421797583136, 8916.0, 8917.77705557363, 8917.866232006525, 8643.2653224476, 8701.17338852808, 8736.475811451333, 8753.299736021136, 8755.3433492488, 8773.956130219372, 8813.294936405104, 8833.646654133827, 8834.337424693142, 8842.336824738139, 8733.956330218372, 8779.64881404743, 8801.0, 8809.942806863186, 8814.471131732116, 8680.913190868137, 8755.605997730117, 8761.474311541328, 8762.948446186434, 8781.56092195394, 42402.36396454025, 42692.359614605804, 42773.14453710908, 42822.357664635056, 42950.35574466385, 3498.0, 3660.560732712065, 3675.191457879262, 3733.21602463483, 4100.180380185947, 31888.20279493008, 32742.345153096805, 32989.50515742266, 33371.33257334864, 33382.49926251108, 4321.459817522809, 4366.148601022802, 4372.103718737683, 4430.180416622903, 4506.752128632924, 368860.15569922247, 376046.0, 376213.0, 377596.0, 377939.0, 59451.10823337654, 59693.403065968785, 59706.0, 59981.40018599758, 60303.396966030654, 62394.0, 62572.687136564935, 62654.686726566986, 62674.0, 62764.68617656882, 16451.177441127897, 16628.0, 16674.916625416794, 16702.164891755365, 16732.0, 12573.182743121668, 12573.308468034164, 12595.181313214613, 12637.684057898443, 12639.11526193176, 14969.925150374178, 17263.39578114785, 17464.738028929576, 17481.825181748274, 17515.0, 5494.36814766299, 5679.602427830012, 5692.800751973661, 6223.564350495421, 6371.916774148406, 996.2080146283722, 1052.3054783842626, 1062.2564205056337, 1102.5920409448556, 1208.4924331780674, 32812.67187328144, 33001.0, 33043.173920652174, 33592.66407335895, 33738.49392259118, 1103.6358001859367, 1125.0268517732266, 1131.3833960491552, 1140.0480598700012, 1182.869884312725, 16662.0, 17317.826821731873, 17325.30698772035, 17325.306987720604, 17415.65168696619, 523578.0, 524032.0, 526069.0, 530457.0, 531063.0, 60161.39838601558, 60243.69878150669, 60265.69867150636, 60458.39541604616, 60566.394336056954, 1290.8580056193812, 1376.779715245556, 1404.7471455138173, 1429.685469196775, 1430.0775999480277, 32767.0, 33230.83384583062, 33519.17384989328, 33705.494417583264, 34202.0, 50519.49480505148, 50925.745371272904, 51010.23484647807, 51028.0, 51117.74441127771, 395026.0, 397156.0, 397243.0, 398164.0, 401677.0, 23596.29211123669, 24893.377665558506, 28147.296317591405, 28239.29401764972, 29246.976355827443, 47752.28371574359, 48481.0, 48991.26513102378, 49169.75415122901, 49504.75247623739, 41465.79267103645, 42287.788561057, 42797.35803962881, 43445.24360683949, 45235.0, 42404.57595424006, 42611.36082958696, 42971.140577188904, 43064.56935430731, 43332.566674332855, 41998.79000604978, 42793.57206427896, 42993.140137197704, 43395.783021085954, 43410.131797364505, 35873.46189807207, 37654.0, 37918.241635167695, 38166.63118232217, 38500.22999540049, 28169.859150704116, 28786.424271514872, 28908.566371504865, 29040.0, 29198.0], "value": 20230.6790876786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6470870342799, 406.5994994929994, 406.7498488429617, 409.2449430800174, 421.7743507223634, 12682.80975785364, 17818.0, 19326.550508711833, 19550.90224548877, 19616.117274722637, 18911.81088189121, 19295.0, 19459.610807783836, 19659.21363145476, 19732.112054957524, 5674.460926212014, 5797.42025797419, 5807.82576522705, 5816.069428891378, 5846.678432686201, 5759.971200143993, 5799.681017544033, 5839.211706419622, 5840.094785308284, 5872.060470324749, 4161.417401563784, 6152.815415537519, 6471.223453185625, 6486.3513648635235, 6626.701798419059, 6441.420272175526, 6528.902066469007, 6537.052127441518, 6563.146790917198, 6573.276939536647, 5657.57568182388, 5749.511291540224, 5788.363280039192, 5798.10129429939, 5818.156367326714, 19916.80083199164, 23442.413939651473, 23779.524409511887, 23860.88069559641, 23967.40081497959, 2352.9529409411716, 2383.3922349800864, 2417.190241269177, 2418.818588605862, 2543.4404431025146, 13743.312834358243, 14391.640208994755, 14516.491922782652, 14916.850831491764, 15026.248687565687, 1899.7530321058312, 1939.4666466721624, 1951.756030496188, 1966.577185905023, 2007.9397618071482, 82482.0, 85190.0, 85264.0, 85900.0, 85978.57010714969, 10564.0, 10635.255532112833, 10799.352038877692, 10979.615713449992, 11205.271657342246, 15309.846901530842, 15362.615934601501, 15395.153266570222, 15443.768343474856, 15452.99555528887, 7986.7603971880935, 8046.919530804734, 8076.990376202974, 8191.0, 8394.0, 7658.923410765821, 7703.3067023968115, 7786.727464538714, 7790.766277011699, 7862.33170180541, 6663.000549917454, 6810.250872404032, 6816.693248803716, 6839.2818754031105, 6893.0, 1910.8375788057892, 1927.6144771045847, 1965.6953172258322, 1985.3944546913042, 2005.8295044921344, 954.5942974235921, 1032.7108409645311, 1039.3504059962524, 1045.5869931377063, 1085.1210519479248, 19231.711524327147, 19733.60532789365, 19824.4052678417, 19924.203031878562, 20197.798022019884, 1040.8178568750438, 1044.6761503933806, 1082.8429877667852, 1091.47063674118, 1117.452448300327, 11063.72340691489, 11597.942010290064, 11620.709482263012, 11663.416829158508, 11673.76652466946, 452809.0, 456586.0, 458072.0, 460603.0, 461533.0, 83622.0, 84811.0, 85564.0, 86142.0, 88657.0, 1036.528379587286, 1050.1283934334638, 1060.3054998975683, 1069.395791377869, 1079.4548752879903, 17362.47912562625, 17535.298588056336, 17835.286588536314, 17931.37240196587, 17980.0, 30911.69088309088, 35615.0, 37418.812905935294, 40074.59925400709, 40222.79888600538, 50975.0, 52505.7374713124, 52637.7368113157, 52896.47103529069, 53073.0, 8548.529830859114, 8659.437136586102, 8770.605322760619, 8862.335324850534, 9121.863172052557, 8601.784955376166, 11959.342236177094, 13474.52839150625, 13744.0, 13824.86175138276, 11764.764704706029, 12138.878611214128, 12181.69545761363, 12286.262824230575, 12426.0, 11762.58830940913, 11832.585859494877, 11863.466144023367, 12029.15795894279, 12180.269183848997, 12002.879971200176, 12299.446524906221, 12389.194702344319, 12497.312647804458, 12566.434510446868, 8661.220490155663, 8716.520591367536, 8893.955530222307, 8951.597178126869, 8990.190882820316, 11975.76048479008, 12028.894943384697, 12041.819372709591, 12052.397380131133, 12283.896250408097], "value": 9490.238458494352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.6969931765348, 1491.4332553629622, 1531.5635044012456, 1658.162627872924, 1814.7912990006153, 8205.138460461647, 8529.701460448878, 8530.701425450103, 8841.38110332277, 8857.689980850671, 8521.403501754865, 8711.390202685814, 8735.344849136309, 8773.166549177833, 8777.692780752675, 2023.2412845183057, 2265.3430505153488, 2315.5021670340916, 2343.4844334246523, 2344.4490544721975, 2335.0543030072763, 2359.563480756057, 2363.2555744940373, 2366.160013195317, 2367.7987371073477, 2291.7708229177115, 2303.401115709919, 2338.462153704649, 2339.87130707811, 2351.5296940611947, 2012.456636708088, 2191.5726433345503, 2255.3459496745922, 2256.3569382725846, 2268.5576312619046, 2308.8845557722047, 2309.6997390339316, 2334.0430423526273, 2334.568104900599, 2334.6498025296173, 8667.696630617898, 8724.171203735636, 8734.694285700034, 8739.868901966476, 8747.737567872973, 5024.145895197825, 5136.897262054776, 5139.408967968657, 5142.228665700138, 5145.948540514584, 3304.7521435892163, 3312.867485300585, 3367.006733013742, 3414.7951122932704, 3416.79499230047, 1085.4952447112053, 1116.7487315354063, 1127.5264388956657, 1128.9661310160627, 1143.645469904324, 12183.086268529896, 12207.93896030523, 12221.572244971383, 12237.510499580007, 12273.509059637603, 4511.909761804811, 4526.343680166357, 4613.423322084739, 4623.976880115645, 4625.814967401334, 10296.897031029594, 10314.1748660107, 10319.226058045677, 10327.896721032845, 10342.896571034344, 5231.529162375328, 5278.604104692164, 5282.339707536558, 5286.7092309922555, 5289.100852855024, 4256.170046840898, 4685.1800934836265, 4806.49531799163, 4814.181589129857, 4879.731614761151, 3861.4787003754695, 3957.703172262034, 3985.740926839746, 4005.1989602079702, 4068.7762173080764, 1272.2175861844898, 1274.15905502368, 1290.2129700882642, 1304.1066869194633, 1332.5136325241217, 1034.5603118674533, 1036.1192985962023, 1038.631285893512, 1050.7005503431485, 1058.8200005999, 5959.106134079922, 6122.6326420414025, 6136.325004249529, 6177.227846519185, 6203.100550420254, 430.2191522386858, 431.424048894729, 432.7273817494958, 435.69283655023133, 446.38176126064985, 4281.892952676146, 4299.720518166309, 4333.43665323506, 4335.7615331157085, 4345.065810850682, 10200.795984080276, 10635.361878287327, 10673.679789606324, 10692.251542391958, 10726.141908647289, 10183.0, 10552.525136368882, 10609.893901061045, 10616.734581635366, 10664.306820056672, 7667.079950405987, 7945.8410831781885, 8016.55908925003, 8033.437659363905, 8046.155153708776, 5940.673262970578, 6179.567430280017, 6197.256329240339, 6275.717592708248, 6349.9682501587195, 9829.361091529028, 10090.949545252226, 10178.083972442515, 10202.642907498499, 10260.846087308846, 10224.897751022692, 10291.0, 10388.844167337345, 10389.9480502597, 10409.635662751767, 7840.137584865546, 7871.0, 7985.480943738638, 8049.2755651989255, 8064.5967701615855, 8352.832943340978, 8408.453450525696, 8434.578271086299, 8439.535825529654, 8480.491170529787, 7364.0, 7720.613969301625, 7799.961000194962, 7866.213378662088, 7898.0, 7664.233576642291, 7681.462297639112, 7736.303732664087, 7837.725679601187, 7850.214978502333, 6714.697838597177, 6850.349216824394, 6905.482088843256, 6923.9653801730665, 6945.895811562932, 5102.821401250939, 5216.139337009351, 5314.62797604164, 5356.57147428197, 5469.124940009579, 5135.101357262539, 5150.562202212854, 5225.451327610698, 5402.162664786807, 5426.647267927572], "value": 4549.889582556258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.41461953863507, 334.6101791413004, 339.6467673619436, 340.5011657921145, 340.86024729860765, 5285.735713214338, 5327.733613319338, 5337.973310133453, 5357.383900851399, 5369.731513424333, 5001.924971125427, 5123.0, 5239.685618862862, 5273.683578985264, 5280.551153151977, 4157.979210103946, 4215.3044747616605, 4216.7680777557225, 4224.387463817745, 4227.746335219881, 4194.370844373338, 4215.683823713219, 4218.599233072853, 4218.599233072869, 4228.873133805991, 4000.919521848637, 4023.718339716221, 4185.100203456256, 4197.160567886435, 4198.0, 4137.462129923121, 4140.482439695038, 4160.105577300879, 4175.958240417603, 4186.497620285585, 3700.204456041937, 3707.3141468828353, 3710.350688629479, 3720.516332876709, 3740.869069582579, 5018.573421259197, 5127.154019586764, 5130.51260130287, 5138.845834624967, 5157.742112894341, 4789.185838407479, 4807.259861878731, 4812.8796780080775, 4832.613390928717, 4836.347093142416, 5524.817697009699, 5565.777368905279, 5578.0, 5581.0512212923495, 5588.692621905793, 3929.528456585228, 4097.795110244506, 4102.343625020012, 4111.773852438115, 4111.951452379654, 5716.971415142939, 5741.684207368593, 5749.885002299972, 5776.768929242825, 5780.595358324919, 4171.874843754692, 4181.456410666594, 4197.160567886435, 4198.874033778991, 4208.179405015992, 3859.0, 4091.2022155679356, 4108.958910410857, 4243.893902652459, 4251.511076226212, 4663.650226233046, 4676.672632915731, 4677.532246775295, 4706.505816889246, 4708.152532544175, 5552.91670624941, 5571.554275657938, 5583.330000399897, 5593.860153496195, 5602.663840169603, 1385.6189547874415, 1416.2564653556965, 1433.677422579911, 1440.1431148466854, 1442.935067921946, 902.6930843513237, 903.3270213690711, 903.9050899655441, 908.7773495493515, 911.0980129671577, 4730.448329064271, 4857.684250523705, 4927.926081108786, 4933.9013219736125, 4952.356193694796, 5043.125418511413, 5085.618578606619, 5106.017306500935, 5179.0, 5179.860430705239, 4788.826737449278, 4794.250098713945, 4819.59033482158, 4935.851924442272, 5061.2661164131, 3039.2098054505987, 3046.1014000869795, 3068.815871047744, 3070.3091804343844, 3098.597182366323, 5955.553333500005, 5959.821205363759, 5966.791162309299, 6005.519558435315, 6020.849478762978, 5503.862403439946, 5770.769169233267, 5795.391483894215, 5803.7968671096305, 5819.214406055213, 5827.941720582825, 5864.736086876101, 5867.853303667357, 5914.378990206139, 5927.614705044159, 5589.357223919302, 5619.661321744277, 5741.770329186953, 5742.799002034909, 5763.769449222152, 5630.380658127521, 5646.209530665628, 5652.604317697722, 5682.89732798867, 5693.629914055573, 5774.509166720875, 5909.468147866541, 5915.201447804663, 5915.467607915309, 5939.683523425953, 3994.6604538614542, 4029.6023865799802, 4120.299549076724, 4128.649064829523, 4133.834646614102, 5662.518685911744, 5690.886182276248, 5709.885802283848, 5733.885322293448, 5753.1945527627, 5540.753330500766, 5556.249906262603, 5574.609777315549, 5575.219469274224, 5576.972115139399, 5347.224652425299, 5523.944760552343, 5561.833145005657, 5575.386707462257, 5581.934684166884, 5447.073997420527, 5471.699056551928, 5493.066178749542, 5518.420565840529, 5535.5848311376, 5498.202760599611, 5594.41258667834, 5651.547876169979, 5654.3497497788285, 5655.0, 5530.336359636869, 5547.694876781654, 5548.889022219614, 5552.611317207757, 5563.610547261653], "value": 4226.938797112078, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.6606696651675, 698.0262533765398, 760.8097975506123, 824.7731873734723, 868.9695860644877, 14230.715385692292, 15024.624384390381, 15228.695426091472, 15330.923345383257, 15342.693146137099, 13975.301234938262, 14021.0, 14076.507322243699, 14094.718105637907, 14109.858901410982, 674.9561278516893, 792.053496072194, 796.8924195233657, 815.9714409995652, 817.3052905030736, 780.3601047141346, 784.0943710014942, 784.1883650421814, 789.7038610521055, 798.2576204130156, 843.2621456225802, 844.6832437835811, 845.9280961118312, 845.9873101903477, 846.4751853850621, 709.2977951827705, 837.4305472278847, 848.516345682961, 852.5694524265268, 856.3235044315015, 628.1143587541544, 629.5341447328989, 630.5869655375736, 630.782380078872, 630.9085182648536, 14075.366608502642, 14079.0848594841, 14084.92957535216, 14100.153990760587, 14101.64745881351, 13872.0, 13995.440182392693, 14006.649833754136, 14049.297535123203, 14055.0, 11883.702907427383, 11906.88093119075, 11970.491070319611, 12082.33547154906, 12134.332611706353, 4473.932891006638, 4519.548045195487, 4554.0, 4637.768111594441, 4700.976495117503, 58401.70799146019, 58843.705781471246, 58889.41110588925, 58988.0, 59148.70425647887, 10263.640772572924, 10353.43056131905, 10804.891951080546, 10839.83740243897, 10950.288231264942, 20226.39320820378, 20227.19091236334, 20376.388708338774, 20409.183632654825, 20419.4895127623, 8013.7996550085545, 8059.314958228499, 8238.382121340923, 8343.624536895853, 8345.082040975487, 4630.166570017362, 4687.484376718558, 4694.248920172756, 4697.060587882437, 4702.952970470252, 3258.7067163955358, 3324.484704870749, 3337.0823023668686, 3345.1971526833386, 3353.899383018513, 529.6742503360406, 620.0358442621766, 633.5027003801994, 637.4677144584232, 640.1709785827271, 733.0726630812027, 752.1087511299128, 768.6886810841618, 783.122902349361, 807.983840323202, 9968.700938971842, 10061.54723037465, 10304.896951030394, 10553.788924221626, 10599.258051936291, 631.6052467207995, 736.7582636399883, 751.1549506804845, 761.7636161541311, 807.4065561812064, 4537.160625284333, 4852.199387101159, 4886.438059623118, 4889.706617602955, 5085.186370180827, 76859.61570192114, 77436.0, 77876.61061694655, 78239.0, 78242.77802724189, 66620.0, 67046.32953670499, 67757.66121169363, 70355.64822175959, 70678.29321706717, 61033.37082864642, 61391.693041534505, 62115.0, 62247.377526225064, 62352.688236558526, 9594.520273986132, 9677.854832177663, 9699.5150242489, 9716.076972687584, 9766.36518626287, 38685.419718704805, 39456.0, 39562.40656390214, 40258.1948361037, 40599.59400405958, 49386.50613493963, 52635.73682131565, 54952.17571736347, 55777.0, 56039.0, 12214.511419543118, 12268.263904165779, 12403.379831008593, 12435.813462798245, 12451.0, 13636.181829090287, 13668.453261869414, 13834.100783449043, 13882.444702211798, 14200.289985500476, 13007.869921300666, 13381.19712817234, 13421.32893355348, 13435.3334927088, 13490.190588564717, 12727.0, 13035.087543872218, 13440.865591343962, 13542.322883855964, 13575.32123393846, 12290.692732681755, 12304.753904921672, 12461.563845265735, 12549.808694962805, 12836.294003829878, 9677.580604848788, 9779.951100244738, 10254.128399086161, 10308.793824123326, 10349.223808214263, 9862.309638325536, 10230.6419275325, 10242.129418999171, 10245.538950747085, 10276.845847312446], "value": 7055.879469307153, "unit": "score"}], "name": "dromaeo_css", "value": 7218.68633383008, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 111.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 150.0, 207.0, 133.0, 161.0, 152.0, 125.0, 177.0, 123.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0, 163.0, 165.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 151.0, 76.0, 74.0, 76.0, 73.0, 134.0, 75.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 152.0, 92.0, 92.0, 92.0, 123.0, 93.0, 93.0, 129.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 65.0, 55.0, 55.0, 54.0, 55.0, 56.0, 107.0, 52.0, 52.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 64.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 83.0, 79.0, 80.0, 79.0, 81.0, 80.0, 81.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 123.0, 127.0, 116.0, 127.0, 117.0, 120.0, 191.0, 126.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 163.0, 164.0, 166.0, 162.0, 163.0, 159.0, 158.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 64.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1533.4, "alertThreshold": 2.0}]} 15:40:51 INFO - Return code: 0 15:40:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:40:51 ERROR - # TBPL SUCCESS # 15:40:51 INFO - Running post-action listener: _resource_record_post_action 15:40:51 INFO - ##### 15:40:51 INFO - ##### Finished run-tests step (success) 15:40:51 INFO - ##### 15:40:51 INFO - Running post-run listener: _resource_record_post_run 15:40:51 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 546107392; Read time: 0; Write time: 658660 15:40:51 INFO - TinderboxPrint: CPU usage
13.2% 15:40:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:40:51 INFO - TinderboxPrint: I/O write bytes / time
546,107,392 / 658,660 15:40:51 INFO - TinderboxPrint: CPU idle
8,269.4 (86.8%) 15:40:51 INFO - TinderboxPrint: CPU user
1,207.8 (12.7%) 15:40:51 INFO - TinderboxPrint: Swap in / out
0 / 0 15:40:51 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 255901696; Read time: 0; Write time: 376976 15:40:51 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 290205696; Read time: 0; Write time: 281684 15:40:52 INFO - Running post-run listener: _upload_blobber_files 15:40:52 INFO - Blob upload gear active. 15:40:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40:52 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 15:40:52 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'] 15:40:52 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 15:40:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:56 INFO - (blobuploader) - INFO - Done attempting. 15:40:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:40:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:57 INFO - (blobuploader) - INFO - Done attempting. 15:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:58 INFO - (blobuploader) - INFO - Done attempting. 15:40:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:40:58 INFO - Return code: 0 15:40:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:40:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:40:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f6846c1276eb9aa360dd9bb219860f1fea02bef65284c8e586c54ecb6220d2897fb09a8b0087ec6303a14be3fe8e0a94f80a3d11192dfad24c609ba471060a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9a4779925aaa588a673e4bf9a2d15cecd0fdd34ec4daaef60b114c4ff786484f1ac07cd74835e0cdef00e8507609896701ad653e861c1c21687335334fb0f1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a219f17b831f176abec49d421eea630cc6e8b9422dfb1f15deaa8439d5bdf36be79a9e4f7385daea5f8b7f706e1dfc136199569970ffcb1c6c1ecec0637a65a"} 15:40:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:40:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:40:58 INFO - Contents: 15:40:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f6846c1276eb9aa360dd9bb219860f1fea02bef65284c8e586c54ecb6220d2897fb09a8b0087ec6303a14be3fe8e0a94f80a3d11192dfad24c609ba471060a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9a4779925aaa588a673e4bf9a2d15cecd0fdd34ec4daaef60b114c4ff786484f1ac07cd74835e0cdef00e8507609896701ad653e861c1c21687335334fb0f1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a219f17b831f176abec49d421eea630cc6e8b9422dfb1f15deaa8439d5bdf36be79a9e4f7385daea5f8b7f706e1dfc136199569970ffcb1c6c1ecec0637a65a"} 15:40:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:40:58 INFO - Copying logs to upload dir... 15:40:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:40:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.637970 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 15:40:57.444945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 15:40:57.449971) ========= 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=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f6846c1276eb9aa360dd9bb219860f1fea02bef65284c8e586c54ecb6220d2897fb09a8b0087ec6303a14be3fe8e0a94f80a3d11192dfad24c609ba471060a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9a4779925aaa588a673e4bf9a2d15cecd0fdd34ec4daaef60b114c4ff786484f1ac07cd74835e0cdef00e8507609896701ad653e861c1c21687335334fb0f1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a219f17b831f176abec49d421eea630cc6e8b9422dfb1f15deaa8439d5bdf36be79a9e4f7385daea5f8b7f706e1dfc136199569970ffcb1c6c1ecec0637a65a"} build_url:https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/cFUcvWfYTQWn0Ag_dqGxyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f6846c1276eb9aa360dd9bb219860f1fea02bef65284c8e586c54ecb6220d2897fb09a8b0087ec6303a14be3fe8e0a94f80a3d11192dfad24c609ba471060a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9a4779925aaa588a673e4bf9a2d15cecd0fdd34ec4daaef60b114c4ff786484f1ac07cd74835e0cdef00e8507609896701ad653e861c1c21687335334fb0f1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a219f17b831f176abec49d421eea630cc6e8b9422dfb1f15deaa8439d5bdf36be79a9e4f7385daea5f8b7f706e1dfc136199569970ffcb1c6c1ecec0637a65a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 15:40:57.475685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:40:57.476046) ========= 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=52faae308a556c440401f8e5000001e8-1463692979.608809-946283170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:40:57.558797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 15:40:57.559173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 15:40:57.559534) ========= ========= Total master_lag: 0.16 =========