builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1464867125.92 results: success (0) buildid: 20160602013026 builduid: 0d63d29f854f4d009a532882a0ac1b4d revision: 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:05.915429) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:05.916315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:05.916774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:05.932474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:05.932827) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 04:32:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-02 04:32:06 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.052428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.052770) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018434 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.102611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.102989) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 04:32:06,588 truncating revision to first 12 chars 2016-06-02 04:32:06,588 Setting DEBUG logging. 2016-06-02 04:32:06,588 attempt 1/10 2016-06-02 04:32:06,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a84c4e71f09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 04:32:06,870 unpacking tar archive at: mozilla-inbound-4a84c4e71f09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.747978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.748301) ========= script_repo_revision: 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.748717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.748985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:32:06.758226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 04:32:06.758494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:07 INFO - MultiFileLogger online at 20160602 04:32:07 in /builds/slave/test 04:32:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:32:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:07 INFO - {'append_to_log': False, 04:32:07 INFO - 'base_work_dir': '/builds/slave/test', 04:32:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:32:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:07 INFO - 'branch': 'Mozilla-Inbound', 04:32:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:07 INFO - 'config_files': ('talos/linux_config.py',), 04:32:07 INFO - 'default_actions': ('clobber', 04:32:07 INFO - 'read-buildbot-config', 04:32:07 INFO - 'download-and-extract', 04:32:07 INFO - 'populate-webroot', 04:32:07 INFO - 'create-virtualenv', 04:32:07 INFO - 'install', 04:32:07 INFO - 'run-tests'), 04:32:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:07 INFO - 'download_minidump_stackwalk': True, 04:32:07 INFO - 'download_symbols': 'ondemand', 04:32:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:07 INFO - 'installer_path': 'installer.exe', 04:32:07 INFO - 'log_level': 'info', 04:32:07 INFO - 'log_name': 'talos', 04:32:07 INFO - 'log_to_console': True, 04:32:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:07 INFO - 'opt_config_files': (), 04:32:07 INFO - 'pip_index': False, 04:32:07 INFO - 'sps_profile': False, 04:32:07 INFO - 'sps_profile_interval': 0, 04:32:07 INFO - 'suite': 'dromaeojs-e10s', 04:32:07 INFO - 'system_bits': '32', 04:32:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:07 INFO - 'title': 'talos-linux64-ix-001', 04:32:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:07 INFO - 'use_talos_json': True, 04:32:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:07 INFO - 'work_dir': 'build'} 04:32:07 INFO - ##### 04:32:07 INFO - ##### Running clobber step. 04:32:07 INFO - ##### 04:32:07 INFO - Running pre-action listener: _resource_record_pre_action 04:32:07 INFO - Running main action method: clobber 04:32:07 INFO - rmtree: /builds/slave/test/build 04:32:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:07 INFO - Running post-action listener: _resource_record_post_action 04:32:07 INFO - ##### 04:32:07 INFO - ##### Finished clobber step (success) 04:32:07 INFO - ##### 04:32:07 INFO - ##### 04:32:07 INFO - ##### Running read-buildbot-config step. 04:32:07 INFO - ##### 04:32:07 INFO - Running pre-action listener: _resource_record_pre_action 04:32:07 INFO - Running main action method: read_buildbot_config 04:32:07 INFO - Using buildbot properties: 04:32:07 INFO - { 04:32:07 INFO - "project": "", 04:32:07 INFO - "product": "firefox", 04:32:07 INFO - "script_repo_revision": "production", 04:32:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:32:07 INFO - "repository": "", 04:32:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:32:07 INFO - "buildid": "20160602013026", 04:32:07 INFO - "pgo_build": "True", 04:32:07 INFO - "basedir": "/builds/slave/test", 04:32:07 INFO - "buildnumber": 1112, 04:32:07 INFO - "slavename": "talos-linux64-ix-001", 04:32:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:32:07 INFO - "platform": "ubuntu64_hw", 04:32:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:32:07 INFO - "branch": "mozilla-inbound", 04:32:07 INFO - "repo_path": "integration/mozilla-inbound", 04:32:07 INFO - "revision": "4a84c4e71f09c49947381b3b9a8551ab6f10c5f8", 04:32:07 INFO - "stage_platform": "linux64-pgo", 04:32:07 INFO - "builduid": "0d63d29f854f4d009a532882a0ac1b4d", 04:32:07 INFO - "slavebuilddir": "test" 04:32:07 INFO - } 04:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:32:07 INFO - Running post-action listener: _resource_record_post_action 04:32:07 INFO - ##### 04:32:07 INFO - ##### Finished read-buildbot-config step (success) 04:32:07 INFO - ##### 04:32:07 INFO - ##### 04:32:07 INFO - ##### Running download-and-extract step. 04:32:07 INFO - ##### 04:32:07 INFO - Running pre-action listener: _resource_record_pre_action 04:32:07 INFO - Running main action method: download_and_extract 04:32:07 INFO - mkdir: /builds/slave/test/build/tests 04:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:07 INFO - https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:08 INFO - Downloaded 1361 bytes. 04:32:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:08 INFO - Using the following test package requirements: 04:32:08 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:32:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:32:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'jsshell-linux-x86_64.zip'], 04:32:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:32:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:32:08 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:32:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:32:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:32:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:08 INFO - https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:09 INFO - Downloaded 24423260 bytes. 04:32:09 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'] 04:32:09 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 04:32:10 INFO - Return code: 0 04:32:10 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 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:12 INFO - Downloaded 24423260 bytes. 04:32:12 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'] 04:32:12 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 04:32:13 INFO - Return code: 0 04:32: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')]} 04:32:13 INFO - https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:14 INFO - Downloaded 10834055 bytes. 04:32:14 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'] 04:32:14 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 04:32:14 INFO - Return code: 0 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbJouRCFQX6lMLseSc8NAw/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 04:32:16 INFO - Downloaded 59073726 bytes. 04:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:16 INFO - mkdir: /builds/slave/test/properties 04:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:16 INFO - Contents: 04:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:17 INFO - Running post-action listener: _resource_record_post_action 04:32:17 INFO - Running post-action listener: set_extra_try_arguments 04:32:17 INFO - ##### 04:32:17 INFO - ##### Finished download-and-extract step (success) 04:32:17 INFO - ##### 04:32:17 INFO - ##### 04:32:17 INFO - ##### Running populate-webroot step. 04:32:17 INFO - ##### 04:32:17 INFO - Running pre-action listener: _resource_record_pre_action 04:32:17 INFO - Running main action method: populate_webroot 04:32:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:17 INFO - '--tppagecycles', 04:32:17 INFO - '7'], 04:32:17 INFO - 'tests': ['tsvgm']}}, 04:32:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['damp', 'tps']}, 04:32:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'tests': ['damp', 'tps']}, 04:32:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['dromaeo_dom']}, 04:32:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['a11yr', 04:32:17 INFO - 'ts_paint', 04:32:17 INFO - 'tpaint', 04:32:17 INFO - 'sessionrestore', 04:32:17 INFO - 'sessionrestore_no_auto_restore', 04:32:17 INFO - 'tabpaint']}, 04:32:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['tsvgx', 04:32:17 INFO - 'tsvgr_opacity', 04:32:17 INFO - 'tart', 04:32:17 INFO - 'tscrollx', 04:32:17 INFO - 'cart']}, 04:32:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:17 INFO - 'tsvgr_opacity', 04:32:17 INFO - 'tart', 04:32:17 INFO - 'tscrollx', 04:32:17 INFO - 'cart']}, 04:32:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'talos_options': ['--disable-e10s'], 04:32:17 INFO - 'tests': ['tp5o']}, 04:32:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'tests': ['tp5o']}, 04:32:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'talos_options': ['--disable-e10s', 04:32:17 INFO - '--xperf_path', 04:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:17 INFO - 'tests': ['tp5n']}, 04:32:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:17 INFO - 'talos_options': ['--xperf_path', 04:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:17 INFO - 'tests': ['tp5n']}}, 04:32:17 INFO - 'talos.zip': {'path': '', 04:32:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:17 INFO - Running post-action listener: _resource_record_post_action 04:32:17 INFO - ##### 04:32:17 INFO - ##### Finished populate-webroot step (success) 04:32:17 INFO - ##### 04:32:17 INFO - ##### 04:32:17 INFO - ##### Running create-virtualenv step. 04:32:17 INFO - ##### 04:32:17 INFO - Running pre-action listener: _resource_record_pre_action 04:32:17 INFO - Running main action method: create_virtualenv 04:32:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:32:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:17 INFO - Using real prefix '/usr' 04:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:19 INFO - Installing pip.................done. 04:32:19 INFO - Return code: 0 04:32:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:19 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:19 INFO - Using env: {'DISPLAY': ':0', 04:32:19 INFO - 'HOME': '/home/cltbld', 04:32:19 INFO - 'LANG': 'en_US.UTF-8', 04:32:19 INFO - 'LANGUAGE': 'en_US:en', 04:32:19 INFO - 'LOGNAME': 'cltbld', 04:32:19 INFO - 'MAIL': '/var/mail/cltbld', 04:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:19 INFO - 'MOZ_NO_REMOTE': '1', 04:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:19 INFO - 'NO_EM_RESTART': '1', 04:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:19 INFO - 'PWD': '/builds/slave/test', 04:32:19 INFO - 'SHELL': '/bin/bash', 04:32:19 INFO - 'SHLVL': '1', 04:32:19 INFO - 'TERM': 'linux', 04:32:19 INFO - 'TMOUT': '86400', 04:32:19 INFO - 'USER': 'cltbld', 04:32:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:19 INFO - '_': '/tools/buildbot/bin/python'} 04:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:20 INFO - Cleaning up... 04:32:20 INFO - Return code: 0 04:32:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:32:20 INFO - Using env: {'DISPLAY': ':0', 04:32:20 INFO - 'HOME': '/home/cltbld', 04:32:20 INFO - 'LANG': 'en_US.UTF-8', 04:32:20 INFO - 'LANGUAGE': 'en_US:en', 04:32:20 INFO - 'LOGNAME': 'cltbld', 04:32:20 INFO - 'MAIL': '/var/mail/cltbld', 04:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:20 INFO - 'MOZ_NO_REMOTE': '1', 04:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:20 INFO - 'NO_EM_RESTART': '1', 04:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:20 INFO - 'PWD': '/builds/slave/test', 04:32:20 INFO - 'SHELL': '/bin/bash', 04:32:20 INFO - 'SHLVL': '1', 04:32:20 INFO - 'TERM': 'linux', 04:32:20 INFO - 'TMOUT': '86400', 04:32:20 INFO - 'USER': 'cltbld', 04:32:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:20 INFO - '_': '/tools/buildbot/bin/python'} 04:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:20 INFO - Downloading/unpacking psutil>=3.1.1 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:22 INFO - Installing collected packages: psutil 04:32:22 INFO - Running setup.py install for psutil 04:32:22 INFO - building 'psutil._psutil_linux' extension 04:32:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:32:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:32:22 INFO - building 'psutil._psutil_posix' extension 04:32:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:32:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:22 INFO - Successfully installed psutil 04:32:22 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:32:23 INFO - Using env: {'DISPLAY': ':0', 04:32:23 INFO - 'HOME': '/home/cltbld', 04:32:23 INFO - 'LANG': 'en_US.UTF-8', 04:32:23 INFO - 'LANGUAGE': 'en_US:en', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MAIL': '/var/mail/cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SHLVL': '1', 04:32:23 INFO - 'TERM': 'linux', 04:32:23 INFO - 'TMOUT': '86400', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - '_': '/tools/buildbot/bin/python'} 04:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:25 INFO - Installing collected packages: mozsystemmonitor 04:32:25 INFO - Running setup.py install for mozsystemmonitor 04:32:25 INFO - Successfully installed mozsystemmonitor 04:32:25 INFO - Cleaning up... 04:32:25 INFO - Return code: 0 04:32:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:25 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:25 INFO - Using env: {'DISPLAY': ':0', 04:32:25 INFO - 'HOME': '/home/cltbld', 04:32:25 INFO - 'LANG': 'en_US.UTF-8', 04:32:25 INFO - 'LANGUAGE': 'en_US:en', 04:32:25 INFO - 'LOGNAME': 'cltbld', 04:32:25 INFO - 'MAIL': '/var/mail/cltbld', 04:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:25 INFO - 'MOZ_NO_REMOTE': '1', 04:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:25 INFO - 'NO_EM_RESTART': '1', 04:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:25 INFO - 'PWD': '/builds/slave/test', 04:32:25 INFO - 'SHELL': '/bin/bash', 04:32:25 INFO - 'SHLVL': '1', 04:32:25 INFO - 'TERM': 'linux', 04:32:25 INFO - 'TMOUT': '86400', 04:32:25 INFO - 'USER': 'cltbld', 04:32:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:25 INFO - '_': '/tools/buildbot/bin/python'} 04:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:28 INFO - Downloading docopt-0.6.1.tar.gz 04:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:28 INFO - Running setup.py install for blobuploader 04:32:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:28 INFO - Running setup.py install for requests 04:32:28 INFO - Running setup.py install for docopt 04:32:28 INFO - Successfully installed blobuploader requests docopt 04:32:28 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:28 INFO - Using env: {'DISPLAY': ':0', 04:32:28 INFO - 'HOME': '/home/cltbld', 04:32:28 INFO - 'LANG': 'en_US.UTF-8', 04:32:28 INFO - 'LANGUAGE': 'en_US:en', 04:32:28 INFO - 'LOGNAME': 'cltbld', 04:32:28 INFO - 'MAIL': '/var/mail/cltbld', 04:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:28 INFO - 'MOZ_NO_REMOTE': '1', 04:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:28 INFO - 'NO_EM_RESTART': '1', 04:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:28 INFO - 'PWD': '/builds/slave/test', 04:32:28 INFO - 'SHELL': '/bin/bash', 04:32:28 INFO - 'SHLVL': '1', 04:32:28 INFO - 'TERM': 'linux', 04:32:28 INFO - 'TMOUT': '86400', 04:32:28 INFO - 'USER': 'cltbld', 04:32:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:28 INFO - '_': '/tools/buildbot/bin/python'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:29 INFO - Running setup.py (path:/tmp/pip-08Ufc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:29 INFO - Running setup.py (path:/tmp/pip-mWP3HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:29 INFO - Running setup.py (path:/tmp/pip-dTC3T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:29 INFO - Running setup.py (path:/tmp/pip-xBBASg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:29 INFO - Running setup.py (path:/tmp/pip-B5zhrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:29 INFO - Running setup.py (path:/tmp/pip-SA3Zhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:29 INFO - Running setup.py (path:/tmp/pip-flIxkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:29 INFO - Running setup.py (path:/tmp/pip-YbsHz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:29 INFO - Running setup.py (path:/tmp/pip-TmEAeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:29 INFO - Running setup.py (path:/tmp/pip-x9yYTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:29 INFO - Running setup.py (path:/tmp/pip-jsyBiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:29 INFO - Running setup.py (path:/tmp/pip-FZxgBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:29 INFO - Running setup.py (path:/tmp/pip-zYUSni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:29 INFO - Running setup.py (path:/tmp/pip-RYVsss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:30 INFO - Running setup.py (path:/tmp/pip-_hsNiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:30 INFO - Running setup.py (path:/tmp/pip-veYyov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:30 INFO - Running setup.py (path:/tmp/pip-PtptDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:30 INFO - Running setup.py install for manifestparser 04:32:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:30 INFO - Running setup.py install for mozcrash 04:32:30 INFO - Running setup.py install for mozdebug 04:32:30 INFO - Running setup.py install for mozdevice 04:32:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:30 INFO - Running setup.py install for mozfile 04:32:30 INFO - Running setup.py install for mozhttpd 04:32:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:30 INFO - Running setup.py install for mozinfo 04:32:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:30 INFO - Running setup.py install for mozInstall 04:32:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozleak 04:32:31 INFO - Running setup.py install for mozlog 04:32:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for moznetwork 04:32:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozprocess 04:32:31 INFO - Running setup.py install for mozprofile 04:32:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozrunner 04:32:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozscreenshot 04:32:31 INFO - Running setup.py install for moztest 04:32:31 INFO - Running setup.py install for mozversion 04:32:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:32 INFO - Using env: {'DISPLAY': ':0', 04:32:32 INFO - 'HOME': '/home/cltbld', 04:32:32 INFO - 'LANG': 'en_US.UTF-8', 04:32:32 INFO - 'LANGUAGE': 'en_US:en', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MAIL': '/var/mail/cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SHLVL': '1', 04:32:32 INFO - 'TERM': 'linux', 04:32:32 INFO - 'TMOUT': '86400', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - '_': '/tools/buildbot/bin/python'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:32 INFO - Running setup.py (path:/tmp/pip-K1mmmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:32 INFO - Running setup.py (path:/tmp/pip-UfjHMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:32 INFO - Running setup.py (path:/tmp/pip-bh0R5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:32 INFO - Running setup.py (path:/tmp/pip-0bt8go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:32 INFO - Running setup.py (path:/tmp/pip-_ZDeOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:32 INFO - Running setup.py (path:/tmp/pip-tfzO73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:32 INFO - Running setup.py (path:/tmp/pip-FRJh1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:32 INFO - Running setup.py (path:/tmp/pip-0JDHxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:32 INFO - Running setup.py (path:/tmp/pip-T9NBAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:32 INFO - Running setup.py (path:/tmp/pip-w8jldI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:32 INFO - Running setup.py (path:/tmp/pip-HgnsRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:33 INFO - Running setup.py (path:/tmp/pip-nOMFJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:33 INFO - Running setup.py (path:/tmp/pip-pH_Mni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:33 INFO - Running setup.py (path:/tmp/pip-p6Fnb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:33 INFO - Running setup.py (path:/tmp/pip-x701g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:33 INFO - Running setup.py (path:/tmp/pip-wt6ZWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:33 INFO - Running setup.py (path:/tmp/pip-4OcrOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:35 INFO - Downloading blessings-1.6.tar.gz 04:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:35 INFO - Installing collected packages: blessings 04:32:35 INFO - Running setup.py install for blessings 04:32:35 INFO - Successfully installed blessings 04:32:35 INFO - Cleaning up... 04:32:35 INFO - Return code: 0 04:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:35 INFO - Reading from file tmpfile_stdout 04:32:35 INFO - Current package versions: 04:32:35 INFO - argparse == 1.2.1 04:32:35 INFO - blessings == 1.6 04:32:35 INFO - blobuploader == 1.2.4 04:32:35 INFO - docopt == 0.6.1 04:32:35 INFO - manifestparser == 1.1 04:32:35 INFO - mozInstall == 1.12 04:32:35 INFO - mozcrash == 0.17 04:32:35 INFO - mozdebug == 0.1 04:32:35 INFO - mozdevice == 0.48 04:32:35 INFO - mozfile == 1.2 04:32:35 INFO - mozhttpd == 0.7 04:32:35 INFO - mozinfo == 0.9 04:32:35 INFO - mozleak == 0.1 04:32:35 INFO - mozlog == 3.2 04:32:35 INFO - moznetwork == 0.27 04:32:35 INFO - mozprocess == 0.22 04:32:35 INFO - mozprofile == 0.28 04:32:35 INFO - mozrunner == 6.11 04:32:35 INFO - mozscreenshot == 0.1 04:32:35 INFO - mozsystemmonitor == 0.3 04:32:35 INFO - moztest == 0.7 04:32:35 INFO - mozversion == 1.4 04:32:35 INFO - psutil == 3.1.1 04:32:35 INFO - requests == 1.2.3 04:32:35 INFO - wsgiref == 0.1.2 04:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:35 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 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:35 INFO - Using env: {'DISPLAY': ':0', 04:32:35 INFO - 'HOME': '/home/cltbld', 04:32:35 INFO - 'LANG': 'en_US.UTF-8', 04:32:35 INFO - 'LANGUAGE': 'en_US:en', 04:32:35 INFO - 'LOGNAME': 'cltbld', 04:32:35 INFO - 'MAIL': '/var/mail/cltbld', 04:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:35 INFO - 'MOZ_NO_REMOTE': '1', 04:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:35 INFO - 'NO_EM_RESTART': '1', 04:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:35 INFO - 'PWD': '/builds/slave/test', 04:32:35 INFO - 'SHELL': '/bin/bash', 04:32:35 INFO - 'SHLVL': '1', 04:32:35 INFO - 'TERM': 'linux', 04:32:35 INFO - 'TMOUT': '86400', 04:32:35 INFO - 'USER': 'cltbld', 04:32:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:35 INFO - '_': '/tools/buildbot/bin/python'} 04:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:36 INFO - Cleaning up... 04:32:36 INFO - Return code: 0 04:32:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:36 INFO - Using env: {'DISPLAY': ':0', 04:32:36 INFO - 'HOME': '/home/cltbld', 04:32:36 INFO - 'LANG': 'en_US.UTF-8', 04:32:36 INFO - 'LANGUAGE': 'en_US:en', 04:32:36 INFO - 'LOGNAME': 'cltbld', 04:32:36 INFO - 'MAIL': '/var/mail/cltbld', 04:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:36 INFO - 'MOZ_NO_REMOTE': '1', 04:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:36 INFO - 'NO_EM_RESTART': '1', 04:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:36 INFO - 'PWD': '/builds/slave/test', 04:32:36 INFO - 'SHELL': '/bin/bash', 04:32:36 INFO - 'SHLVL': '1', 04:32:36 INFO - 'TERM': 'linux', 04:32:36 INFO - 'TMOUT': '86400', 04:32:36 INFO - 'USER': 'cltbld', 04:32:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:36 INFO - '_': '/tools/buildbot/bin/python'} 04:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:36 INFO - Downloading/unpacking jsonschema 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:38 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:38 INFO - warning: no files found matching '*.txt' 04:32:38 INFO - no previously-included directories found matching 'build' 04:32:38 INFO - no previously-included directories found matching 'dist' 04:32:38 INFO - no previously-included directories found matching '.git*' 04:32:38 INFO - Installing collected packages: jsonschema, functools32 04:32:38 INFO - Running setup.py install for functools32 04:32:38 INFO - warning: no files found matching '*.txt' 04:32:38 INFO - no previously-included directories found matching 'build' 04:32:38 INFO - no previously-included directories found matching 'dist' 04:32:38 INFO - no previously-included directories found matching '.git*' 04:32:38 INFO - Successfully installed jsonschema functools32 04:32:38 INFO - Cleaning up... 04:32:38 INFO - Return code: 0 04:32:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc992644f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32: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', 'flake8'] in /builds/slave/test/build 04:32: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 flake8 04:32:38 INFO - Using env: {'DISPLAY': ':0', 04:32:38 INFO - 'HOME': '/home/cltbld', 04:32:38 INFO - 'LANG': 'en_US.UTF-8', 04:32:38 INFO - 'LANGUAGE': 'en_US:en', 04:32:38 INFO - 'LOGNAME': 'cltbld', 04:32:38 INFO - 'MAIL': '/var/mail/cltbld', 04:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:38 INFO - 'MOZ_NO_REMOTE': '1', 04:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:38 INFO - 'NO_EM_RESTART': '1', 04:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:38 INFO - 'PWD': '/builds/slave/test', 04:32:38 INFO - 'SHELL': '/bin/bash', 04:32:38 INFO - 'SHLVL': '1', 04:32:38 INFO - 'TERM': 'linux', 04:32:38 INFO - 'TMOUT': '86400', 04:32:38 INFO - 'USER': 'cltbld', 04:32:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:38 INFO - '_': '/tools/buildbot/bin/python'} 04:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:38 INFO - Downloading/unpacking flake8 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:41 INFO - no previously-included directories found matching 'docs/_build' 04:32:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:41 INFO - Running setup.py install for pep8 04:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:41 INFO - no previously-included directories found matching 'docs/_build' 04:32:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:41 INFO - Cleaning up... 04:32:41 INFO - Return code: 0 04:32:41 INFO - Running post-action listener: _resource_record_post_action 04:32:41 INFO - Running post-action listener: _start_resource_monitoring 04:32:41 INFO - Starting resource monitoring. 04:32:41 INFO - ##### 04:32:41 INFO - ##### Finished create-virtualenv step (success) 04:32:41 INFO - ##### 04:32:41 INFO - ##### 04:32:41 INFO - ##### Running install step. 04:32:41 INFO - ##### 04:32:41 INFO - Running pre-action listener: _resource_record_pre_action 04:32:41 INFO - Running main action method: install 04:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:41 INFO - Reading from file tmpfile_stdout 04:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:42 INFO - Reading from file tmpfile_stdout 04:32:42 INFO - Output received: 04:32:42 INFO - Usage: mozinstall [options] installer 04:32:42 INFO - Options: 04:32:42 INFO - -h, --help show this help message and exit 04:32:42 INFO - -d DEST, --destination=DEST 04:32:42 INFO - Directory to install application into. [default: 04:32:42 INFO - "/builds/slave/test"] 04:32:42 INFO - --app=APP Application being installed. [default: firefox] 04:32:42 INFO - mkdir: /builds/slave/test/build/application 04:32:42 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'] 04:32:42 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 04:32:58 INFO - Reading from file tmpfile_stdout 04:32:58 INFO - Output received: 04:32:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:58 INFO - Running post-action listener: _resource_record_post_action 04:32:58 INFO - ##### 04:32:58 INFO - ##### Finished install step (success) 04:32:58 INFO - ##### 04:32:58 INFO - ##### 04:32:58 INFO - ##### Running run-tests step. 04:32:58 INFO - ##### 04:32:58 INFO - Running pre-action listener: _resource_record_pre_action 04:32:58 INFO - Running main action method: run_tests 04:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:58 INFO - Python 2.7.3 04:32:58 INFO - Return code: 0 04:32:58 INFO - grabbing minidump binary from tooltool 04:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:58 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 0xf959c0>, '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 0xf968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf96d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:58 INFO - Return code: 0 04:32:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:59 INFO - Return code: 0 04:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:32:59 INFO - Using env: {'DISPLAY': ':0', 04:32:59 INFO - 'HOME': '/home/cltbld', 04:32:59 INFO - 'LANG': 'en_US.UTF-8', 04:32:59 INFO - 'LANGUAGE': 'en_US:en', 04:32:59 INFO - 'LOGNAME': 'cltbld', 04:32:59 INFO - 'MAIL': '/var/mail/cltbld', 04:32:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:59 INFO - 'MOZ_NO_REMOTE': '1', 04:32:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:59 INFO - 'NO_EM_RESTART': '1', 04:32:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:59 INFO - 'PWD': '/builds/slave/test', 04:32:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:59 INFO - 'SHELL': '/bin/bash', 04:32:59 INFO - 'SHLVL': '1', 04:32:59 INFO - 'TERM': 'linux', 04:32:59 INFO - 'TMOUT': '86400', 04:32:59 INFO - 'USER': 'cltbld', 04:32:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207', 04:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:59 INFO - '_': '/tools/buildbot/bin/python'} 04:32:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:33:00 INFO - mozversion application_buildid: 20160602013026 04:33:00 INFO - mozversion application_changeset: 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 04:33:00 INFO - mozversion application_display_name: Nightly 04:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:00 INFO - mozversion application_name: Firefox 04:33:00 INFO - mozversion application_remotingname: firefox 04:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:33:00 INFO - mozversion application_vendor: Mozilla 04:33:00 INFO - mozversion application_version: 49.0a1 04:33:00 INFO - mozversion platform_buildid: 20160602013026 04:33:00 INFO - mozversion platform_changeset: 4a84c4e71f09c49947381b3b9a8551ab6f10c5f8 04:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:33:00 INFO - mozversion platform_version: 49.0a1 04:33:00 INFO - using testdate: 1464867180 04:33:00 INFO - actual date: 1464867180 04:33:00 INFO - starting webserver on 'localhost:52129' 04:33:00 INFO - SUITE-START | Running 2 tests 04:33:00 INFO - TEST-START | dromaeo_css 04:33:00 INFO - operating with platform_type : linux_ 04:33:00 INFO - Initialising browser for dromaeo_css test... 04:33:00 INFO - TEST-INFO | started process 21350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJ08qd/profile http://localhost:52129/getInfo.html) 04:33:04 INFO - PROCESS | 21350 | __metrics Screen width/height:1600/1200 04:33:04 INFO - PROCESS | 21350 | colorDepth:24 04:33:04 INFO - PROCESS | 21350 | Browser inner width/height: 1024/697 04:33:04 INFO - PROCESS | 21350 | __metrics 04:33:05 ERROR - PROCESS | 21350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:33:06 INFO - TEST-INFO | 21350: exit 0 04:33:06 INFO - Browser initialized. 04:33:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:06 INFO - TEST-INFO | started process 21468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJ08qd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:18 INFO - PROCESS | 21468 | RSS: Main: 167862272 04:33:18 INFO - PROCESS | 21468 | 04:34:07 INFO - PROCESS | 21468 | 1464867247641 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:36:15 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52129/tests/dromaeo/cssquery-ext.html) 04:36:16 INFO - PROCESS | 21468 | RSS: Main: 171335680 04:36:16 INFO - PROCESS | 21468 | 04:39:18 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-ext.html (next: http://localhost:52129/tests/dromaeo/cssquery-jquery.html) 04:39:18 INFO - PROCESS | 21468 | RSS: Main: 169934848 04:39:18 INFO - PROCESS | 21468 | 04:42:20 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52129/tests/dromaeo/cssquery-mootools.html) 04:42:21 INFO - PROCESS | 21468 | RSS: Main: 170975232 04:42:21 INFO - PROCESS | 21468 | 04:45:23 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52129/tests/dromaeo/cssquery-prototype.html) 04:45:23 INFO - PROCESS | 21468 | RSS: Main: 168792064 04:45:23 INFO - PROCESS | 21468 | 04:48:26 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52129/tests/dromaeo/cssquery-yui.html) 04:48:26 INFO - PROCESS | 21468 | RSS: Main: 170725376 04:48:26 INFO - PROCESS | 21468 | 04:51:29 INFO - PROCESS | 21468 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-yui.html (next: http://localhost:52129/tests/dromaeo/cssquery-dojo.html) 04:51:30 INFO - PROCESS | 21468 | RSS: Main: 172195840 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | __start_tp_report 04:51:30 INFO - PROCESS | 21468 | _x_x_mozilla_page_load 04:51:30 INFO - PROCESS | 21468 | _x_x_mozilla_page_load_details 04:51:30 INFO - PROCESS | 21468 | |i|pagename|runs| 04:51:30 INFO - PROCESS | 21468 | |0;dojo.html;3138.2781960149164;3159.2417819723246;3186.4264432402174;3203.263249452626;3203.5995500562444;5448.809291674787;5503.147012213103;5534.474224948628;5553.22254884316;5555.694436805974;5384.973075134619;5411.83764487065;5472.151816468454;5517.751701173447;5545.279113715222;4942.209246520549;4967.155583550805;5077.187649976005;5123.129068058421;5168.095583272931;876.0661463524626;4975.303457515951;5071.467495912932;5077.289179514871;5090.185570308751;4957.529034741694;4976.751162441881;4988.551030407262;5010.048090862742;5034.093863104658;4890.144224760653;5004.199328107522;5012.473690262543;5019.447860735353;5066.544011039025;4932.556069953722;4933.087378834927;4951.257311403318;4955.207166853323;4970.353853998957;5409.377921539034;5485.533729632986;5495.175723641446;5513;5516.475934786189;5844.444777746107;5909.261342332208;5960.612560183574;5976.790812321591;5981.850453738648;5927.318358388798;5966.433188847052;5974.193483879664;5991.64050156992;6027.517798576104;5536.058869992111;5542.196381524656;5545.916811247835;5554.805581804618;5569.136783798477;5923.733431995484;6007.519398448114;6037.215162028996;6037.849053773603;6088.11722300264;5839.211706419664;5840.269966254218;5843.328017277982;5843.766249350064;5845.678487683218;5926.140709597084;5935.1987481690285;5936.5250779937505;5944;5961.225040744675;5699.544036477072;5828.067509198508;5848.795292164839;5902.793402230901;5943.762249509971;5757.107648314518;5796.94203057964;5799;5841.707914604252;5918.319393269829;4425.933610995838;4445.933311000337;4447.043885564619;4450.3991961085485;4489.19194544985;3912.1002169501176;3950.288947989332;3981.024648961023;3992.720509564361;3993.7603743775467;5693.117566777156;5705.942940570624;5718.656880587178;5726.627769194989;5758.337791153987;5821.330546987151;5960.672163031075;6011.27864656244;6035.275766907999;6045.244344456943;5673.971630141906;5705.686187259657;5712.028955077647;5714.457126572969;5717.056685646905;5119.795208191705;5128.230765385222;5130.076586214443;5137.614678899097;5155.072087024371;5955.583109182316;6115.785947491817;6159.3224745277985;6172.69136543171;6190.164327815687;5965.343812180657;6006.339302676614;6019.969900150471;6029.909551356645;6066.059760737093;6135.478484328882;6164.815055548341;6166.414190651881;6169.136320914986;6185.84535386619;5704.572157088152;5730.598858079894;5776.884462310814;5896.6756828374855;5899.793507227227;5942.286925568959;5947.464728174485;5948.375420580776;5959.165716799738;5995.460408563075;5672.716364181857;5712;5726.455986681259;5732.713364331683;5803.158542011469;5681.488666020078;5743.396943321059;5752.798652047159;5767.134929760569;5794.652320860761;5585.5531557476115;5674.574406919415;5678.488935995781;5719.542436605145;5748.051571490657;5871.794487192928;5871.853203669943;5885.882282354414;5890.1164825276555;5899.587028908107;5581.748821303132;5613.57898157648;5646.407127251579;5762.0204565223175;5770.221020162225 04:51:30 INFO - PROCESS | 21468 | |1;ext.html;566.7336351914602;601.7502736364409;612.8529153003275;613.6808859393116;626.4362074133277;43749.562504374946;44470.77764611176;44648;44668;47535.762321188435;43403.131937361235;43914;43964;43994.560054399444;44044.77977610115;8904.866427003584;9024.8646270306;9064.864027039566;9070.818583628323;9082;8842.955785221066;8875.334349923749;8923.15230053144;8945.821083578325;8947.194752472276;8900.19898209161;8933.731988040337;8974.147455991702;8985.955070224672;9030.051844556325;8910.287177025855;8933.06202848698;8964.282857371394;8983.427900117485;9002.549872506348;8811.295096392274;8958.776030599287;8967.372283940127;8967.865482017774;8979.775505612346;42633.57366426327;42953;43200.783996080136;43250;43282.350764738556;3464.7921124732343;3575.284943011382;3818.083659921627;3983.342748446503;3991.102002049545;31841.681583184105;32257.51613725796;32363.51454728181;32556.674433255837;32910;4070.450489183952;4100.487439070116;4113.629773320416;4131.958680413188;4254.234237837188;338176.3091184553;338839;338969;339399;339773;61114.083288750706;62105;62282.37717622856;62307.6884615574;62322.376776232566;36422;37591.81204093962;37632.81183594064;38987;64656.35343646597;17559.385421510186;17757.378491752985;17771.644567108586;17861.821381786274;17867.553311167325;12464.439100240512;12469.563565275354;12485.063620228519;12561.120721549587;12582.68543286407;20003.799962000485;20074;20222.595548088957;20223.29218477346;20341.288054918008;7261.782146535506;7432.85134297311;7442;7470.2903224193615;7624.923750762532;995.8207522645994;1068.3696618994675;1077.8975997280245;1154.203599516331;1166.8716441191461;33290.833545832116;33479.330413391595;33654;33933.83033084868;34042.65957340395;1143.1026644084354;1172.0740614914293;1205.0600531585378;1232.7904256276454;1286.6847622332402;17378.82621173772;17710.468685939442;17774;17815.821841781417;17843.73234401485;524507;524889;529000;529020;530459;59995.700021499615;60181.699091505136;60580.394196057474;60668.39331606716;60878;1384.8338199415932;1384.9030567860354;1426.664733787559;1430.1990885104167;1432.6275168456068;31875.20311992219;33235.66764332326;33297;33433;33695.494567581016;53033.73483132559;53337;53340;53379.7331013358;53450.73274633758;438025;440340;440930;441204;441298;28209.294767630974;28325.291867703472;29525.852370738867;29526.409471810013;29613.6673849673;48633.51366486432;48780.75609622071;48949.2657610129;50125;50473.49526504835;41458.79270603628;42684.15842574183;42732.14535709331;42953.78523107364;42966.14067718691;41670.79164604157;41840;42065.57934420617;42267.57732422637;42276.78861605672;42692.1461570773;45155.32267016063;45880;46550.30174547317;46582.30126548172;40660.79669601633;42104.78947605242;42875.914961652554;45600.315995259436;46688;33924;34959.30081398409;35123.648763512036;35197.47203791894;35531.46702799512 04:51:30 INFO - PROCESS | 21468 | |2;jquery.html;378.6561186257069;381.0891968196012;387.67822707153067;396.5799884167231;412.24353311673076;13850.930745346259;15242.161681107535;17996.64006719865;19507.804921950777;19535.902320488396;17802.109894505254;18242.5439364016;18620.348287809928;19184.328548500805;19196.136173872175;5461.262729531502;5530.917036244459;5594.552435805146;5678.26182596264;5734.713264336788;5481.725913704318;5540.86147846303;5547.278853749007;5555.444455554452;5564.721763911808;5344.331958505187;5488.670679759207;5508.91736623951;5539.750711217985;5607.663540187581;5551.139573366115;5574.442555744434;5587.273654424939;5614.8596285093;5640.633358831683;4777.80888764449;4948.826791062295;4950.9009819803405;4970.776315065795;4972.975135124301;21492;22053.779462205333;22345;22591.887040564856;22596.66105008426;2266.648669456237;2345.4253707841517;2543.78377837884;2747.4367754610257;3004.3690824926794;8843.159899809507;9392.154706076417;9476.241900647932;9874.703758887244;13556.86443135566;1813.6735387630222;1887.1036257777446;1895.6872116100826;1937.7965313642005;1938.1569017477443;82768.58615706943;83005;85335.57332213361;86076.56961715214;87277;10839.783204335869;10875.619353322596;10914.945425272823;10985.505652245669;11108.444577771079;15005.399784008518;15213;15253;15357.846421535642;15375.154366509725;8168.509889406655;8171.9182808172345;8208.343332533503;8260.215279548433;8374.078851326349;7670.961645191738;7883.802904927423;8007.359411247086;8140.511569305861;8192.385571082194;4577.5880170784785;4641.976790116028;4665.486796452387;4698.8355407560575;4758.262469317261;1909.9331523396615;1945.9902700486691;1973.2304401283511;2004.7293615362032;2055.208744633327;916.3631276262934;995.3778888194878;1006.4917216805612;1042.3902017319801;1117.3296022386667;17691.823081769275;18596.814031859507;18902.243910243713;19554.804451955584;20472.283470078477;976.2921881635757;981.8527220916919;1026.6150193677372;1081.4376524207369;1132.6554033151297;9781.608735650636;10756.19328550362;10821.134309255242;10829.891701083046;10868.61959831402;451146;454592;458419;459056;461094.72336936765;87180.56409717911;90161;91296.54351728332;94870.52564737132;96235.51882240544;1031.293563908725;1033.1837848099917;1035.29082578434;1047.0994944347856;1049.6221360310283;16516.75224871604;16677.332906683598;17087.743683845;17178.828211718224;17451.738223926397;31904.6809531911;41618.95952601209;41672.583274168086;42284.57715422929;42701.14597708091;59424.70287648534;59595.40404595899;61057;61121.694391529534;62381;8140.226678465537;8240.21717936795;8241.546714930737;8345.916540834514;8531.061583225965;9136.588853501475;12305.323207223688;13025.153365031243;13226;13439.395227214995;11737.178397512092;11895.881041189477;12006.75986480283;12084.818727718915;12102.213356131822;9499.810003800023;11393.202475826612;11527.135464840003;12089.274643521065;12124.939375303067;11988.100892432927;12095.697607559881;12174.634760957186;12312.876871231172;12328.260304381765;8567.314614830922;8712.825743484967;8782.385233033627;8826.205641492297;8928.598213080297;10936.45317734126;11562.653120406401;11672.182947193614;11777.411129443664;11859.22915010556 04:51:30 INFO - PROCESS | 21468 | |3;mootools.html;1500.197394393999;1528.182422404014;1722.2594284457687;1846.769153855768;1864.6177533605612;8073;8591.226789588936;8792.736217913456;9335.299852511063;9340.53297335133;8830.558472076402;8846.823063538724;8925;8941.239994600466;8955.05971872952;2316.652502124682;2350.670906073151;2351.1183306260154;2351.1888398502488;2356.893939772706;2328.499372634883;2345.144022431817;2365.195833416638;2368.8815559222057;2374.548835721216;2333.509962907783;2346.542424227268;2347.1784875293597;2350.9177178798745;2375.9881200593973;2260.7739226077424;2279.658051292319;2283.3264187064856;2289.6565515172692;2332.6267797152373;2283.8287128465267;2309.6997390339316;2313.1556981701724;2321.3964369264113;2327.7090363704538;8845.778855528599;8907.777305567348;8940.955295223548;8943.552822358855;9013.774655633597;5105.387353517564;5191.480851914778;5363.678179309254;5376.623636345457;5379.327584051994;3234.4165515614245;3270.280538281574;3306.636270010297;3326.3513614845115;3355.79191491063;1028.254515476281;1041.7864337810806;1063.0910571461366;1077.9622713205079;1093.3931667924298;12724.1729287596;12742.554010609585;12752;12758.553450629184;12762.80855787164;4635.258358662598;4693.530646935279;4699.130660827758;4723.409573803275;4872.074305881942;10526.421046842344;10594.735131621772;10596.947015265028;10612.151027917747;10639.946800265949;5485.341758988947;5489.2589500417735;5490.780368785284;5496.862578435491;5499.752511137009;4329.740215587075;4852.95147048525;4909.4845041270155;4988.825391111293;4992.326035985168;3979.621935916083;3992.640662340403;4072.266991941479;4099.692523060723;4123.36087906375;1274.4137696659454;1281.9423125959354;1293.5084667826166;1295.8315418995471;1300.4083142170289;879.8196369744187;978.3298440568234;1045.5295117197293;1056.3239526702916;1083.9566417343217;6312.652804095727;6369.076483909807;6424.26120996082;6438.163038805019;6481.157449531531;476.5496605707573;477.3960939411647;478.7989044601276;486.03764546198727;487.43214155508434;4351.4995775485595;4473.932891006638;4475.910481790346;4514.571115743999;4520.932186017212;11115.72210694739;11593.826092608617;11610.477528511237;11638.6508404748;11638.6508404748;11264.155188360906;11341.26281791681;11350.318980861175;11396.088312934946;11408.201425900274;7786.610669466618;8134.796630084295;8140.470869393471;8287.549678806185;8295.253427191581;6278.121063051085;6518.315576864551;6582.80251592453;6591.901121483277;6649.936010238339;10369.688909332732;10565.313254638424;10665;10698.572057117939;10710.410927399067;10658.520366583367;10688.038076573146;10760.3543787373;10850.131989440984;10897.400642964712;7261.3101755333155;7288.380487658608;7403.851922961403;7941;8083;8572.142785721378;8587;8648;8652.178043085896;8661.826763464569;7542.132654744774;7783.766487005399;7791.337736292478;7839.608019598883;7898.68405263783;7557.35762460197;7590.544567325978;7656.885146722692;7690.9232707422125;7792;7162.964185179041;7170.641467926478;7221.097362829646;7250;7266.091738532684;5255.7123504741585;5357.24998500218;5469.671819690831;5495.945040549704;5498.80754173602;5338.252644629677;5395.81114660985;5401.378841433286;5417.674939503642;5531.170324451365 04:51:30 INFO - PROCESS | 21468 | |4;prototype.html;324.2396580019853;332.8768355708388;338.10571039600256;339.8546896957253;342.245349005443;5412.539934105605;5422.078246698061;5425.2675888755;5570.412432456751;5575.665460072399;5569.415211402805;5578.191162281467;5594.188842617828;5601.075822489284;5607.4112218217115;4336.392904993303;4383.276759334706;4384.583464570861;4395.791157431716;4402.735835849843;4127.793610319487;4290.292101803198;4290.399344091829;4395.692301538894;4405.933910991322;4264.21112094262;4294.527601963781;4300.35494675798;4301.118270754488;4304.698671093025;4270.14597080582;4298.935515967263;4309.758925358811;4313.654907607384;4315.4389929309145;3597.388443964532;3767.9811600942094;3770.2082562661876;3774.9433758493647;3781.810909454516;5343.171808369709;5368.174820561028;5398.973005134949;5401.216823560561;5403.486668766461;4900.754962251909;4927.531884470969;4940.283658869444;4946.3817022872145;4954.423699676148;5529.834104976857;5816.858896196091;5819.912701309484;5835.416458354173;5836.649801011953;4063.3295506241434;4096.201240758053;4121.814518346681;4141.7929103545;4144.668426525871;5980.28236611605;5985.79759828494;6000.279966404016;6000.399960004008;6052.910476114298;4091.89770255746;4160.2303573838935;4170.748775367378;4194.8112334945;4240.363945408213;4184.28867092595;4187.43469631602;4194.790260486963;4206.558311377323;4234.640055595309;4845;4879.219324908068;4879.731269869789;4884.511548845158;4891.290762839369;5239.607029472805;5869.2956845178;5870.207521984563;5875.618084824473;5919.6744179070565;1472.821742605911;1479.3416929466284;1482.303317440801;1488.2558720639681;1489.4712377106189;900.1268769293774;924.1359329027381;927.0173615967096;934.6775362499926;936.601944173737;5031.496850315012;5064.670796398223;5100.744962751847;5122.410922743858;5135.948640513622;5288.9735551322;5302.496262855023;5358.732063396815;5365.382980957162;5371.328583927009;5018.623603229772;5020.3724534433195;5034.79860805571;5217.50433708797;5703.460065782298;3207.374561960395;3218.7585931055264;3232.288896442779;3240.513922911535;3242.789218700777;6109.327973922865;6254;6301.747930082837;6315.873682526324;6330.525210609223;6113.541484388688;6134.6625935573975;6153.446189842935;6156.78451254204;6158.846028849314;6132.264128304632;6207.317195108534;6231.345708700521;6234.501239900797;6236.844078897973;5750.993576124245;6011.106501452028;6012.398760124128;6049.576529642883;6086.2087928569;5888.911666325094;5927.784804115232;5934.821955341346;5949.553783466171;5987.6108052976415;6005.669688167192;6175.9382406177165;6191.81424557264;6225.408586184305;6226.1905952225925;4158.523724077909;4187.9320773202635;4190.895227619334;4194.119234960693;4207.789610519523;5700.743466544099;5912.73392697321;5982.042873140276;5998.130271110752;6019.548533860066;5844.327902291291;5874.823755287348;5877.147813566923;5877.794277200277;5892.6759028253855;5711.200431939449;5784.595078344475;5814.476697097281;5830.5627077968475;5873.911891321548;5527.270555563857;5735.885282294247;5777.3670671097025;5779.306483222041;5780.901628690535;5864.237649105589;5870.354261031369;5874.295084589706;5885.705714714333;5899.351071382231;5491.2312276282155;5721.971390143022;5730.914036289542;5774.566907481872;5832.387599302012 04:51:30 INFO - PROCESS | 21468 | |5;yui.html;637.3849235487753;686.6017709728358;688.359825362413;702.3713776170327;709.8935159726041;14219.146851188923;14232;14271.928640356784;14287.214203218831;14352.641183970405;13963.162210267366;13966.511172108978;14042;14074.22591757453;14087;677.6543962579095;783.5337973905517;803.1245941923303;806.173671986213;807.8142027333716;802.835418739157;805.9556724380157;808.2442915873647;811.1928631012152;813.9552324622143;864.3042350907517;866.0733015673233;867.652938824469;868.9522076285801;871.4161511787117;853.8377708235478;854.5171977832536;857.7641148684099;858.394831643696;864.0797550608613;621.8227805075531;622.8909940760349;624.4567226512963;630.0328994992665;632.2034236861541;14423.557644235598;14451;14459.638509037253;14484.34820433083;14497.202653854034;13853.653658658513;14975.550733478012;14981.925090374478;15129.924350378178;15215.467458638894;11384.658460246123;11449.942750286194;11472.139589530818;11493.942530287295;11979.221350612183;3690.9052995323077;3722.627737226283;3873.98063009686;3945.0531872350716;3947.5657677655436;75794.62102689451;76476.23523764747;76734;77035.6148219261;77405.22594774037;10989.395583242998;11654.708632284091;11795.41022948849;11844.526218951145;11911.463984120735;21052.78947210539;21215.15139394407;21254.78745212528;21300.25449109274;21568.460788480414;8628.697995570124;8818.206361427503;8833.646654133763;8919.331050171264;8974.775630609287;4520.954790452053;4589.632829373709;4612.584867361954;4634.467036290802;4658.161530924398;3587.856485740593;3681.502997095358;3691.53855768029;3695.4826324314618;3717.126475278307;679.6228093408107;686.193722376206;686.3548264631231;694.9548279361825;696.6342670098239;715.713714514188;738.5974643819131;752.5033477904557;753.5252790741797;773.6054612147846;10105.898941010495;10133.746656333651;10133.797324053625;10188.592456301665;10298.17614590831;729.2889432803081;737.5433518800327;759.810047488128;762.9008228930204;763.6029264782283;4684.414448193976;4720.221163507983;4737.95262047382;4924;4962.404511458576;84630;107435;113181;116165.4191729036;118298;97266;97672;99000;99328.50335748275;100680;85817.57091214503;86886.56556717302;87188.56405718057;87770.12229877747;88641.11358886458;8898.822023559622;8979.46123232608;9151.63393464254;9382.390144640576;9388.257970928084;50833.74583127061;51759;52482.21276680777;52641;52803.73598131985;66847.33152668411;67388.3261167382;74217.88673169799;76783.61608192147;77551.2244877544;11453.713657158638;11570.074394048625;11775.646730598095;12082.33547154915;12285.262884226617;11952.46213920393;12286.139970202;12330.75338493243;12788.936055319664;12811.871881281068;11766.82349764737;12078.335691536699;12177;12638.304893230961;12882.613521594367;10946.39794811293;10983.725406864893;11578.884211157781;12276.87723122793;12281.631551053482;11670.474828632561;11731.178817482694;11962.940185299018;12005.219660722025;12258.938705306417;9470.242380609672;9552.087626178574;9639.18066964316;9755.17684983268;9770;9428.764280892758;9467.526623668928;9696.563654635418;9835.311528193244;9910.405375677483 04:51:30 INFO - PROCESS | 21468 | __end_tp_report 04:51:30 INFO - PROCESS | 21468 | __start_cc_report 04:51:30 INFO - PROCESS | 21468 | _x_x_mozilla_cycle_collect,363 04:51:30 INFO - PROCESS | 21468 | __end_cc_report 04:51:30 INFO - PROCESS | 21468 | __startTimestamp1464868290240__endTimestamp 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | ------- Summary: start ------- 04:51:30 INFO - PROCESS | 21468 | Number of tests: 6 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#0] dojo.html Cycles:165 Average:5470.37 Median:5718.66 stddev:735.16 (12.9%) stddev-sans-first:714.28 04:51:30 INFO - PROCESS | 21468 | Values: 3138.3 3159.2 3186.4 3203.3 3203.6 5448.8 5503.1 5534.5 5553.2 5555.7 5385.0 5411.8 5472.2 5517.8 5545.3 4942.2 4967.2 5077.2 5123.1 5168.1 876.1 4975.3 5071.5 5077.3 5090.2 4957.5 4976.8 4988.6 5010.0 5034.1 4890.1 5004.2 5012.5 5019.4 5066.5 4932.6 4933.1 4951.3 4955.2 4970.4 5409.4 5485.5 5495.2 5513.0 5516.5 5844.4 5909.3 5960.6 5976.8 5981.9 5927.3 5966.4 5974.2 5991.6 6027.5 5536.1 5542.2 5545.9 5554.8 5569.1 5923.7 6007.5 6037.2 6037.8 6088.1 5839.2 5840.3 5843.3 5843.8 5845.7 5926.1 5935.2 5936.5 5944.0 5961.2 5699.5 5828.1 5848.8 5902.8 5943.8 5757.1 5796.9 5799.0 5841.7 5918.3 4425.9 4445.9 4447.0 4450.4 4489.2 3912.1 3950.3 3981.0 3992.7 3993.8 5693.1 5705.9 5718.7 5726.6 5758.3 5821.3 5960.7 6011.3 6035.3 6045.2 5674.0 5705.7 5712.0 5714.5 5717.1 5119.8 5128.2 5130.1 5137.6 5155.1 5955.6 6115.8 6159.3 6172.7 6190.2 5965.3 6006.3 6020.0 6029.9 6066.1 6135.5 6164.8 6166.4 6169.1 6185.8 5704.6 5730.6 5776.9 5896.7 5899.8 5942.3 5947.5 5948.4 5959.2 5995.5 5672.7 5712.0 5726.5 5732.7 5803.2 5681.5 5743.4 5752.8 5767.1 5794.7 5585.6 5674.6 5678.5 5719.5 5748.1 5871.8 5871.9 5885.9 5890.1 5899.6 5581.7 5613.6 5646.4 5762.0 5770.2 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#1] ext.html Cycles:180 Average:60457.50 Median:42914.46 stddev:117082.16 (272.8%) stddev-sans-first:117324.25 04:51:30 INFO - PROCESS | 21468 | Values: 566.7 601.8 612.9 613.7 626.4 43749.6 44470.8 44648.0 44668.0 47535.8 43403.1 43914.0 43964.0 43994.6 44044.8 8904.9 9024.9 9064.9 9070.8 9082.0 8843.0 8875.3 8923.2 8945.8 8947.2 8900.2 8933.7 8974.1 8986.0 9030.1 8910.3 8933.1 8964.3 8983.4 9002.5 8811.3 8958.8 8967.4 8967.9 8979.8 42633.6 42953.0 43200.8 43250.0 43282.4 3464.8 3575.3 3818.1 3983.3 3991.1 31841.7 32257.5 32363.5 32556.7 32910.0 4070.5 4100.5 4113.6 4132.0 4254.2 338176.3 338839.0 338969.0 339399.0 339773.0 61114.1 62105.0 62282.4 62307.7 62322.4 36422.0 37591.8 37632.8 38987.0 64656.4 17559.4 17757.4 17771.6 17861.8 17867.6 12464.4 12469.6 12485.1 12561.1 12582.7 20003.8 20074.0 20222.6 20223.3 20341.3 7261.8 7432.9 7442.0 7470.3 7624.9 995.8 1068.4 1077.9 1154.2 1166.9 33290.8 33479.3 33654.0 33933.8 34042.7 1143.1 1172.1 1205.1 1232.8 1286.7 17378.8 17710.5 17774.0 17815.8 17843.7 524507.0 524889.0 529000.0 529020.0 530459.0 59995.7 60181.7 60580.4 60668.4 60878.0 1384.8 1384.9 1426.7 1430.2 1432.6 31875.2 33235.7 33297.0 33433.0 33695.5 53033.7 53337.0 53340.0 53379.7 53450.7 438025.0 440340.0 440930.0 441204.0 441298.0 28209.3 28325.3 29525.9 29526.4 29613.7 48633.5 48780.8 48949.3 50125.0 50473.5 41458.8 42684.2 42732.1 42953.8 42966.1 41670.8 41840.0 42065.6 42267.6 42276.8 42692.1 45155.3 45880.0 46550.3 46582.3 40660.8 42104.8 42875.9 45600.3 46688.0 33924.0 34959.3 35123.6 35197.5 35531.5 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#2] jquery.html Cycles:180 Average:28051.66 Median:379.87 stddev:75658.55 (19916.8%) stddev-sans-first:75842.26 04:51:30 INFO - PROCESS | 21468 | Values: 378.7 381.1 387.7 396.6 412.2 13850.9 15242.2 17996.6 19507.8 19535.9 17802.1 18242.5 18620.3 19184.3 19196.1 5461.3 5530.9 5594.6 5678.3 5734.7 5481.7 5540.9 5547.3 5555.4 5564.7 5344.3 5488.7 5508.9 5539.8 5607.7 5551.1 5574.4 5587.3 5614.9 5640.6 4777.8 4948.8 4950.9 4970.8 4973.0 21492.0 22053.8 22345.0 22591.9 22596.7 2266.6 2345.4 2543.8 2747.4 3004.4 8843.2 9392.2 9476.2 9874.7 13556.9 1813.7 1887.1 1895.7 1937.8 1938.2 82768.6 83005.0 85335.6 86076.6 87277.0 10839.8 10875.6 10914.9 10985.5 11108.4 15005.4 15213.0 15253.0 15357.8 15375.2 8168.5 8171.9 8208.3 8260.2 8374.1 7671.0 7883.8 8007.4 8140.5 8192.4 4577.6 4642.0 4665.5 4698.8 4758.3 1909.9 1946.0 1973.2 2004.7 2055.2 916.4 995.4 1006.5 1042.4 1117.3 17691.8 18596.8 18902.2 19554.8 20472.3 976.3 981.9 1026.6 1081.4 1132.7 9781.6 10756.2 10821.1 10829.9 10868.6 451146.0 454592.0 458419.0 459056.0 461094.7 87180.6 90161.0 91296.5 94870.5 96235.5 1031.3 1033.2 1035.3 1047.1 1049.6 16516.8 16677.3 17087.7 17178.8 17451.7 31904.7 41619.0 41672.6 42284.6 42701.1 59424.7 59595.4 61057.0 61121.7 62381.0 8140.2 8240.2 8241.5 8345.9 8531.1 9136.6 12305.3 13025.2 13226.0 13439.4 11737.2 11895.9 12006.8 12084.8 12102.2 9499.8 11393.2 11527.1 12089.3 12124.9 11988.1 12095.7 12174.6 12312.9 12328.3 8567.3 8712.8 8782.4 8826.2 8928.6 10936.5 11562.7 11672.2 11777.4 11859.2 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#3] mootools.html Cycles:180 Average:5953.23 Median:4696.33 stddev:3436.37 (73.2%) stddev-sans-first:3429.71 04:51:30 INFO - PROCESS | 21468 | Values: 1500.2 1528.2 1722.3 1846.8 1864.6 8073.0 8591.2 8792.7 9335.3 9340.5 8830.6 8846.8 8925.0 8941.2 8955.1 2316.7 2350.7 2351.1 2351.2 2356.9 2328.5 2345.1 2365.2 2368.9 2374.5 2333.5 2346.5 2347.2 2350.9 2376.0 2260.8 2279.7 2283.3 2289.7 2332.6 2283.8 2309.7 2313.2 2321.4 2327.7 8845.8 8907.8 8941.0 8943.6 9013.8 5105.4 5191.5 5363.7 5376.6 5379.3 3234.4 3270.3 3306.6 3326.4 3355.8 1028.3 1041.8 1063.1 1078.0 1093.4 12724.2 12742.6 12752.0 12758.6 12762.8 4635.3 4693.5 4699.1 4723.4 4872.1 10526.4 10594.7 10596.9 10612.2 10639.9 5485.3 5489.3 5490.8 5496.9 5499.8 4329.7 4853.0 4909.5 4988.8 4992.3 3979.6 3992.6 4072.3 4099.7 4123.4 1274.4 1281.9 1293.5 1295.8 1300.4 879.8 978.3 1045.5 1056.3 1084.0 6312.7 6369.1 6424.3 6438.2 6481.2 476.5 477.4 478.8 486.0 487.4 4351.5 4473.9 4475.9 4514.6 4520.9 11115.7 11593.8 11610.5 11638.7 11638.7 11264.2 11341.3 11350.3 11396.1 11408.2 7786.6 8134.8 8140.5 8287.5 8295.3 6278.1 6518.3 6582.8 6591.9 6649.9 10369.7 10565.3 10665.0 10698.6 10710.4 10658.5 10688.0 10760.4 10850.1 10897.4 7261.3 7288.4 7403.9 7941.0 8083.0 8572.1 8587.0 8648.0 8652.2 8661.8 7542.1 7783.8 7791.3 7839.6 7898.7 7557.4 7590.5 7656.9 7690.9 7792.0 7163.0 7170.6 7221.1 7250.0 7266.1 5255.7 5357.2 5469.7 5495.9 5498.8 5338.3 5395.8 5401.4 5417.7 5531.2 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#4] prototype.html Cycles:180 Average:4852.39 Median:5417.31 stddev:1440.21 (26.6%) stddev-sans-first:1403.58 04:51:30 INFO - PROCESS | 21468 | Values: 324.2 332.9 338.1 339.9 342.2 5412.5 5422.1 5425.3 5570.4 5575.7 5569.4 5578.2 5594.2 5601.1 5607.4 4336.4 4383.3 4384.6 4395.8 4402.7 4127.8 4290.3 4290.4 4395.7 4405.9 4264.2 4294.5 4300.4 4301.1 4304.7 4270.1 4298.9 4309.8 4313.7 4315.4 3597.4 3768.0 3770.2 3774.9 3781.8 5343.2 5368.2 5399.0 5401.2 5403.5 4900.8 4927.5 4940.3 4946.4 4954.4 5529.8 5816.9 5819.9 5835.4 5836.6 4063.3 4096.2 4121.8 4141.8 4144.7 5980.3 5985.8 6000.3 6000.4 6052.9 4091.9 4160.2 4170.7 4194.8 4240.4 4184.3 4187.4 4194.8 4206.6 4234.6 4845.0 4879.2 4879.7 4884.5 4891.3 5239.6 5869.3 5870.2 5875.6 5919.7 1472.8 1479.3 1482.3 1488.3 1489.5 900.1 924.1 927.0 934.7 936.6 5031.5 5064.7 5100.7 5122.4 5135.9 5289.0 5302.5 5358.7 5365.4 5371.3 5018.6 5020.4 5034.8 5217.5 5703.5 3207.4 3218.8 3232.3 3240.5 3242.8 6109.3 6254.0 6301.7 6315.9 6330.5 6113.5 6134.7 6153.4 6156.8 6158.8 6132.3 6207.3 6231.3 6234.5 6236.8 5751.0 6011.1 6012.4 6049.6 6086.2 5888.9 5927.8 5934.8 5949.6 5987.6 6005.7 6175.9 6191.8 6225.4 6226.2 4158.5 4187.9 4190.9 4194.1 4207.8 5700.7 5912.7 5982.0 5998.1 6019.5 5844.3 5874.8 5877.1 5877.8 5892.7 5711.2 5784.6 5814.5 5830.6 5873.9 5527.3 5735.9 5777.4 5779.3 5780.9 5864.2 5870.4 5874.3 5885.7 5899.4 5491.2 5722.0 5730.9 5774.6 5832.4 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - PROCESS | 21468 | [#5] yui.html Cycles:180 Average:20242.33 Median:51296.37 stddev:29480.43 (57.5%) stddev-sans-first:29526.38 04:51:30 INFO - PROCESS | 21468 | Values: 637.4 686.6 688.4 702.4 709.9 14219.1 14232.0 14271.9 14287.2 14352.6 13963.2 13966.5 14042.0 14074.2 14087.0 677.7 783.5 803.1 806.2 807.8 802.8 806.0 808.2 811.2 814.0 864.3 866.1 867.7 869.0 871.4 853.8 854.5 857.8 858.4 864.1 621.8 622.9 624.5 630.0 632.2 14423.6 14451.0 14459.6 14484.3 14497.2 13853.7 14975.6 14981.9 15129.9 15215.5 11384.7 11449.9 11472.1 11493.9 11979.2 3690.9 3722.6 3874.0 3945.1 3947.6 75794.6 76476.2 76734.0 77035.6 77405.2 10989.4 11654.7 11795.4 11844.5 11911.5 21052.8 21215.2 21254.8 21300.3 21568.5 8628.7 8818.2 8833.6 8919.3 8974.8 4521.0 4589.6 4612.6 4634.5 4658.2 3587.9 3681.5 3691.5 3695.5 3717.1 679.6 686.2 686.4 695.0 696.6 715.7 738.6 752.5 753.5 773.6 10105.9 10133.7 10133.8 10188.6 10298.2 729.3 737.5 759.8 762.9 763.6 4684.4 4720.2 4738.0 4924.0 4962.4 84630.0 107435.0 113181.0 116165.4 118298.0 97266.0 97672.0 99000.0 99328.5 100680.0 85817.6 86886.6 87188.6 87770.1 88641.1 8898.8 8979.5 9151.6 9382.4 9388.3 50833.7 51759.0 52482.2 52641.0 52803.7 66847.3 67388.3 74217.9 76783.6 77551.2 11453.7 11570.1 11775.6 12082.3 12285.3 11952.5 12286.1 12330.8 12788.9 12811.9 11766.8 12078.3 12177.0 12638.3 12882.6 10946.4 10983.7 11578.9 12276.9 12281.6 11670.5 11731.2 11962.9 12005.2 12258.9 9470.2 9552.1 9639.2 9755.2 9770.0 9428.8 9467.5 9696.6 9835.3 9910.4 04:51:30 INFO - PROCESS | 21468 | -------- Summary: end -------- 04:51:30 INFO - PROCESS | 21468 | 04:51:30 INFO - TEST-INFO | 21468: exit 0 04:51:30 INFO - TEST-OK | dromaeo_css | took 1110927ms 04:51:30 INFO - TEST-START | kraken 04:51:30 INFO - operating with platform_type : linux_ 04:51:30 INFO - Initialising browser for kraken test... 04:51:30 INFO - TEST-INFO | started process 21703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwyloP/profile http://localhost:52129/getInfo.html) 04:51:35 INFO - PROCESS | 21703 | __metrics Screen width/height:1600/1200 04:51:35 INFO - PROCESS | 21703 | colorDepth:24 04:51:35 INFO - PROCESS | 21703 | Browser inner width/height: 1024/697 04:51:35 INFO - PROCESS | 21703 | __metrics 04:51:36 ERROR - PROCESS | 21703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:51:36 INFO - TEST-INFO | 21703: exit 0 04:51:36 INFO - Browser initialized. 04:51:36 INFO - Running cycle 1/1 for kraken test... 04:51:36 INFO - TEST-INFO | started process 21822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwyloP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:48 INFO - PROCESS | 21822 | RSS: Main: 167583744 04:51:48 INFO - PROCESS | 21822 | 04:51:51 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:52 INFO - PROCESS | 21822 | RSS: Main: 172732416 04:51:52 INFO - PROCESS | 21822 | 04:51:54 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-dft) 04:51:55 INFO - PROCESS | 21822 | RSS: Main: 171659264 04:51:55 INFO - PROCESS | 21822 | 04:51:58 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-fft) 04:51:59 INFO - PROCESS | 21822 | RSS: Main: 167596032 04:51:59 INFO - PROCESS | 21822 | 04:52:01 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator) 04:52:01 INFO - PROCESS | 21822 | RSS: Main: 167890944 04:52:01 INFO - PROCESS | 21822 | 04:52:03 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:04 INFO - PROCESS | 21822 | RSS: Main: 168337408 04:52:04 INFO - PROCESS | 21822 | 04:52:07 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:08 INFO - PROCESS | 21822 | RSS: Main: 168849408 04:52:08 INFO - PROCESS | 21822 | 04:52:11 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:12 INFO - PROCESS | 21822 | RSS: Main: 166137856 04:52:12 INFO - PROCESS | 21822 | 04:52:15 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial) 04:52:15 INFO - PROCESS | 21822 | RSS: Main: 167124992 04:52:15 INFO - PROCESS | 21822 | 04:52:17 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:18 INFO - PROCESS | 21822 | RSS: Main: 168062976 04:52:18 INFO - PROCESS | 21822 | 04:52:19 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:20 INFO - PROCESS | 21822 | RSS: Main: 168431616 04:52:20 INFO - PROCESS | 21822 | 04:52:22 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:23 INFO - PROCESS | 21822 | RSS: Main: 168464384 04:52:23 INFO - PROCESS | 21822 | 04:52:25 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:26 INFO - PROCESS | 21822 | RSS: Main: 168910848 04:52:26 INFO - PROCESS | 21822 | 04:52:29 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:29 INFO - PROCESS | 21822 | RSS: Main: 168726528 04:52:29 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52129/tests/kraken/driver.html?testName=ai-astar) 04:52:31 INFO - PROCESS | 21822 | RSS: Main: 169398272 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | __start_tp_report 04:52:31 INFO - PROCESS | 21822 | _x_x_mozilla_page_load 04:52:31 INFO - PROCESS | 21822 | _x_x_mozilla_page_load_details 04:52:31 INFO - PROCESS | 21822 | |i|pagename|runs| 04:52:31 INFO - PROCESS | 21822 | |0;ai-astar;110;103;110;109;111;110;110;110;109;112 04:52:31 INFO - PROCESS | 21822 | |1;audio-beat-detection;153;126;159;181;133;160;163;131;185;126 04:52:31 INFO - PROCESS | 21822 | |2;audio-dft;162;163;160;162;162;165;168;160;163;160 04:52:31 INFO - PROCESS | 21822 | |3;audio-fft;78;74;76;158;76;77;75;92;158;80 04:52:31 INFO - PROCESS | 21822 | |4;audio-oscillator;83;84;148;84;84;84;142;84;84;136 04:52:31 INFO - PROCESS | 21822 | |5;imaging-gaussian-blur;119;119;118;121;118;119;118;121;117;118 04:52:31 INFO - PROCESS | 21822 | |6;imaging-darkroom;147;149;147;147;148;148;147;148;146;148 04:52:31 INFO - PROCESS | 21822 | |7;imaging-desaturate;95;96;95;97;95;95;95;97;96;100 04:52:31 INFO - PROCESS | 21822 | |8;json-parse-financial;55;59;58;55;60;53;58;54;56;57 04:52:31 INFO - PROCESS | 21822 | |9;json-stringify-tinderbox;61;61;59;60;61;60;61;62;61;60 04:52:31 INFO - PROCESS | 21822 | |10;stanford-crypto-aes;85;78;79;83;80;82;81;81;121;84 04:52:31 INFO - PROCESS | 21822 | |11;stanford-crypto-ccm;124;134;124;126;133;129;132;130;132;142 04:52:31 INFO - PROCESS | 21822 | |12;stanford-crypto-pbkdf2;161;165;166;164;163;162;160;160;165;157 04:52:31 INFO - PROCESS | 21822 | |13;stanford-crypto-sha256-iterative;68;65;62;62;63;62;64;62;63;63 04:52:31 INFO - PROCESS | 21822 | __end_tp_report 04:52:31 INFO - PROCESS | 21822 | __start_cc_report 04:52:31 INFO - PROCESS | 21822 | _x_x_mozilla_cycle_collect,887 04:52:31 INFO - PROCESS | 21822 | __end_cc_report 04:52:31 INFO - PROCESS | 21822 | __startTimestamp1464868351768__endTimestamp 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | ------- Summary: start ------- 04:52:31 INFO - PROCESS | 21822 | Number of tests: 14 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.55 04:52:31 INFO - PROCESS | 21822 | Values: 110.0 103.0 110.0 109.0 111.0 110.0 110.0 110.0 109.0 112.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:159.50 stddev:21.90 (13.7%) stddev-sans-first:23.23 04:52:31 INFO - PROCESS | 21822 | Values: 153.0 126.0 159.0 181.0 133.0 160.0 163.0 131.0 185.0 126.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.51 (1.5%) stddev-sans-first:2.65 04:52:31 INFO - PROCESS | 21822 | Values: 162.0 163.0 160.0 162.0 162.0 165.0 168.0 160.0 163.0 160.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.50 stddev:33.90 (44.3%) stddev-sans-first:35.44 04:52:31 INFO - PROCESS | 21822 | Values: 78.0 74.0 76.0 158.0 76.0 77.0 75.0 92.0 158.0 80.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:84.00 stddev:28.23 (33.6%) stddev-sans-first:29.15 04:52:31 INFO - PROCESS | 21822 | Values: 83.0 84.0 148.0 84.0 84.0 84.0 142.0 84.0 84.0 136.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:1.32 (1.1%) stddev-sans-first:1.39 04:52:31 INFO - PROCESS | 21822 | Values: 119.0 119.0 118.0 121.0 118.0 119.0 118.0 121.0 117.0 118.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 04:52:31 INFO - PROCESS | 21822 | Values: 147.0 149.0 147.0 147.0 148.0 148.0 147.0 148.0 146.0 148.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:1.60 (1.7%) stddev-sans-first:1.64 04:52:31 INFO - PROCESS | 21822 | Values: 95.0 96.0 95.0 97.0 95.0 95.0 95.0 97.0 96.0 100.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.50 stddev:2.27 (4.0%) stddev-sans-first:2.35 04:52:31 INFO - PROCESS | 21822 | Values: 55.0 59.0 58.0 55.0 60.0 53.0 58.0 54.0 56.0 57.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.84 (1.4%) stddev-sans-first:0.88 04:52:31 INFO - PROCESS | 21822 | Values: 61.0 61.0 59.0 60.0 61.0 60.0 61.0 62.0 61.0 60.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:81.50 stddev:12.69 (15.6%) stddev-sans-first:13.46 04:52:31 INFO - PROCESS | 21822 | Values: 85.0 78.0 79.0 83.0 80.0 82.0 81.0 81.0 121.0 84.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:132.00 stddev:5.40 (4.1%) stddev-sans-first:5.17 04:52:31 INFO - PROCESS | 21822 | Values: 124.0 134.0 124.0 126.0 133.0 129.0 132.0 130.0 132.0 142.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.50 stddev:2.83 (1.7%) stddev-sans-first:2.96 04:52:31 INFO - PROCESS | 21822 | Values: 161.0 165.0 166.0 164.0 163.0 162.0 160.0 160.0 165.0 157.0 04:52:31 INFO - PROCESS | 21822 | 04:52:31 INFO - PROCESS | 21822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.90 (3.0%) stddev-sans-first:1.05 04:52:31 INFO - PROCESS | 21822 | Values: 68.0 65.0 62.0 62.0 63.0 62.0 64.0 62.0 63.0 63.0 04:52:31 INFO - PROCESS | 21822 | -------- Summary: end -------- 04:52:31 INFO - PROCESS | 21822 | 04:52:32 INFO - TEST-INFO | 21822: exit 0 04:52:32 INFO - TEST-OK | kraken | took 61785ms 04:52:32 INFO - SUITE-END | took 1172s 04:52:32 INFO - Completed test suite (00:19:32) 04:52:32 INFO - javascript benchmark 04:52:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7320.339013124086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.2781960149164, 3159.2417819723246, 3186.4264432402174, 3203.263249452626, 3203.5995500562444, 5448.809291674787, 5503.147012213103, 5534.474224948628, 5553.22254884316, 5555.694436805974, 5384.973075134619, 5411.83764487065, 5472.151816468454, 5517.751701173447, 5545.279113715222, 4942.209246520549, 4967.155583550805, 5077.187649976005, 5123.129068058421, 5168.095583272931, 876.0661463524626, 4975.303457515951, 5071.467495912932, 5077.289179514871, 5090.185570308751, 4957.529034741694, 4976.751162441881, 4988.551030407262, 5010.048090862742, 5034.093863104658, 4890.144224760653, 5004.199328107522, 5012.473690262543, 5019.447860735353, 5066.544011039025, 4932.556069953722, 4933.087378834927, 4951.257311403318, 4955.207166853323, 4970.353853998957, 5409.377921539034, 5485.533729632986, 5495.175723641446, 5513.0, 5516.475934786189, 5844.444777746107, 5909.261342332208, 5960.612560183574, 5976.790812321591, 5981.850453738648, 5927.318358388798, 5966.433188847052, 5974.193483879664, 5991.64050156992, 6027.517798576104, 5536.058869992111, 5542.196381524656, 5545.916811247835, 5554.805581804618, 5569.136783798477, 5923.733431995484, 6007.519398448114, 6037.215162028996, 6037.849053773603, 6088.11722300264, 5839.211706419664, 5840.269966254218, 5843.328017277982, 5843.766249350064, 5845.678487683218, 5926.140709597084, 5935.1987481690285, 5936.5250779937505, 5944.0, 5961.225040744675, 5699.544036477072, 5828.067509198508, 5848.795292164839, 5902.793402230901, 5943.762249509971, 5757.107648314518, 5796.94203057964, 5799.0, 5841.707914604252, 5918.319393269829, 4425.933610995838, 4445.933311000337, 4447.043885564619, 4450.3991961085485, 4489.19194544985, 3912.1002169501176, 3950.288947989332, 3981.024648961023, 3992.720509564361, 3993.7603743775467, 5693.117566777156, 5705.942940570624, 5718.656880587178, 5726.627769194989, 5758.337791153987, 5821.330546987151, 5960.672163031075, 6011.27864656244, 6035.275766907999, 6045.244344456943, 5673.971630141906, 5705.686187259657, 5712.028955077647, 5714.457126572969, 5717.056685646905, 5119.795208191705, 5128.230765385222, 5130.076586214443, 5137.614678899097, 5155.072087024371, 5955.583109182316, 6115.785947491817, 6159.3224745277985, 6172.69136543171, 6190.164327815687, 5965.343812180657, 6006.339302676614, 6019.969900150471, 6029.909551356645, 6066.059760737093, 6135.478484328882, 6164.815055548341, 6166.414190651881, 6169.136320914986, 6185.84535386619, 5704.572157088152, 5730.598858079894, 5776.884462310814, 5896.6756828374855, 5899.793507227227, 5942.286925568959, 5947.464728174485, 5948.375420580776, 5959.165716799738, 5995.460408563075, 5672.716364181857, 5712.0, 5726.455986681259, 5732.713364331683, 5803.158542011469, 5681.488666020078, 5743.396943321059, 5752.798652047159, 5767.134929760569, 5794.652320860761, 5585.5531557476115, 5674.574406919415, 5678.488935995781, 5719.542436605145, 5748.051571490657, 5871.794487192928, 5871.853203669943, 5885.882282354414, 5890.1164825276555, 5899.587028908107, 5581.748821303132, 5613.57898157648, 5646.407127251579, 5762.0204565223175, 5770.221020162225], "value": 5421.1840312455915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7336351914602, 601.7502736364409, 612.8529153003275, 613.6808859393116, 626.4362074133277, 43749.562504374946, 44470.77764611176, 44648.0, 44668.0, 47535.762321188435, 43403.131937361235, 43914.0, 43964.0, 43994.560054399444, 44044.77977610115, 8904.866427003584, 9024.8646270306, 9064.864027039566, 9070.818583628323, 9082.0, 8842.955785221066, 8875.334349923749, 8923.15230053144, 8945.821083578325, 8947.194752472276, 8900.19898209161, 8933.731988040337, 8974.147455991702, 8985.955070224672, 9030.051844556325, 8910.287177025855, 8933.06202848698, 8964.282857371394, 8983.427900117485, 9002.549872506348, 8811.295096392274, 8958.776030599287, 8967.372283940127, 8967.865482017774, 8979.775505612346, 42633.57366426327, 42953.0, 43200.783996080136, 43250.0, 43282.350764738556, 3464.7921124732343, 3575.284943011382, 3818.083659921627, 3983.342748446503, 3991.102002049545, 31841.681583184105, 32257.51613725796, 32363.51454728181, 32556.674433255837, 32910.0, 4070.450489183952, 4100.487439070116, 4113.629773320416, 4131.958680413188, 4254.234237837188, 338176.3091184553, 338839.0, 338969.0, 339399.0, 339773.0, 61114.083288750706, 62105.0, 62282.37717622856, 62307.6884615574, 62322.376776232566, 36422.0, 37591.81204093962, 37632.81183594064, 38987.0, 64656.35343646597, 17559.385421510186, 17757.378491752985, 17771.644567108586, 17861.821381786274, 17867.553311167325, 12464.439100240512, 12469.563565275354, 12485.063620228519, 12561.120721549587, 12582.68543286407, 20003.799962000485, 20074.0, 20222.595548088957, 20223.29218477346, 20341.288054918008, 7261.782146535506, 7432.85134297311, 7442.0, 7470.2903224193615, 7624.923750762532, 995.8207522645994, 1068.3696618994675, 1077.8975997280245, 1154.203599516331, 1166.8716441191461, 33290.833545832116, 33479.330413391595, 33654.0, 33933.83033084868, 34042.65957340395, 1143.1026644084354, 1172.0740614914293, 1205.0600531585378, 1232.7904256276454, 1286.6847622332402, 17378.82621173772, 17710.468685939442, 17774.0, 17815.821841781417, 17843.73234401485, 524507.0, 524889.0, 529000.0, 529020.0, 530459.0, 59995.700021499615, 60181.699091505136, 60580.394196057474, 60668.39331606716, 60878.0, 1384.8338199415932, 1384.9030567860354, 1426.664733787559, 1430.1990885104167, 1432.6275168456068, 31875.20311992219, 33235.66764332326, 33297.0, 33433.0, 33695.494567581016, 53033.73483132559, 53337.0, 53340.0, 53379.7331013358, 53450.73274633758, 438025.0, 440340.0, 440930.0, 441204.0, 441298.0, 28209.294767630974, 28325.291867703472, 29525.852370738867, 29526.409471810013, 29613.6673849673, 48633.51366486432, 48780.75609622071, 48949.2657610129, 50125.0, 50473.49526504835, 41458.79270603628, 42684.15842574183, 42732.14535709331, 42953.78523107364, 42966.14067718691, 41670.79164604157, 41840.0, 42065.57934420617, 42267.57732422637, 42276.78861605672, 42692.1461570773, 45155.32267016063, 45880.0, 46550.30174547317, 46582.30126548172, 40660.79669601633, 42104.78947605242, 42875.914961652554, 45600.315995259436, 46688.0, 33924.0, 34959.30081398409, 35123.648763512036, 35197.47203791894, 35531.46702799512], "value": 20661.61237845005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6561186257069, 381.0891968196012, 387.67822707153067, 396.5799884167231, 412.24353311673076, 13850.930745346259, 15242.161681107535, 17996.64006719865, 19507.804921950777, 19535.902320488396, 17802.109894505254, 18242.5439364016, 18620.348287809928, 19184.328548500805, 19196.136173872175, 5461.262729531502, 5530.917036244459, 5594.552435805146, 5678.26182596264, 5734.713264336788, 5481.725913704318, 5540.86147846303, 5547.278853749007, 5555.444455554452, 5564.721763911808, 5344.331958505187, 5488.670679759207, 5508.91736623951, 5539.750711217985, 5607.663540187581, 5551.139573366115, 5574.442555744434, 5587.273654424939, 5614.8596285093, 5640.633358831683, 4777.80888764449, 4948.826791062295, 4950.9009819803405, 4970.776315065795, 4972.975135124301, 21492.0, 22053.779462205333, 22345.0, 22591.887040564856, 22596.66105008426, 2266.648669456237, 2345.4253707841517, 2543.78377837884, 2747.4367754610257, 3004.3690824926794, 8843.159899809507, 9392.154706076417, 9476.241900647932, 9874.703758887244, 13556.86443135566, 1813.6735387630222, 1887.1036257777446, 1895.6872116100826, 1937.7965313642005, 1938.1569017477443, 82768.58615706943, 83005.0, 85335.57332213361, 86076.56961715214, 87277.0, 10839.783204335869, 10875.619353322596, 10914.945425272823, 10985.505652245669, 11108.444577771079, 15005.399784008518, 15213.0, 15253.0, 15357.846421535642, 15375.154366509725, 8168.509889406655, 8171.9182808172345, 8208.343332533503, 8260.215279548433, 8374.078851326349, 7670.961645191738, 7883.802904927423, 8007.359411247086, 8140.511569305861, 8192.385571082194, 4577.5880170784785, 4641.976790116028, 4665.486796452387, 4698.8355407560575, 4758.262469317261, 1909.9331523396615, 1945.9902700486691, 1973.2304401283511, 2004.7293615362032, 2055.208744633327, 916.3631276262934, 995.3778888194878, 1006.4917216805612, 1042.3902017319801, 1117.3296022386667, 17691.823081769275, 18596.814031859507, 18902.243910243713, 19554.804451955584, 20472.283470078477, 976.2921881635757, 981.8527220916919, 1026.6150193677372, 1081.4376524207369, 1132.6554033151297, 9781.608735650636, 10756.19328550362, 10821.134309255242, 10829.891701083046, 10868.61959831402, 451146.0, 454592.0, 458419.0, 459056.0, 461094.72336936765, 87180.56409717911, 90161.0, 91296.54351728332, 94870.52564737132, 96235.51882240544, 1031.293563908725, 1033.1837848099917, 1035.29082578434, 1047.0994944347856, 1049.6221360310283, 16516.75224871604, 16677.332906683598, 17087.743683845, 17178.828211718224, 17451.738223926397, 31904.6809531911, 41618.95952601209, 41672.583274168086, 42284.57715422929, 42701.14597708091, 59424.70287648534, 59595.40404595899, 61057.0, 61121.694391529534, 62381.0, 8140.226678465537, 8240.21717936795, 8241.546714930737, 8345.916540834514, 8531.061583225965, 9136.588853501475, 12305.323207223688, 13025.153365031243, 13226.0, 13439.395227214995, 11737.178397512092, 11895.881041189477, 12006.75986480283, 12084.818727718915, 12102.213356131822, 9499.810003800023, 11393.202475826612, 11527.135464840003, 12089.274643521065, 12124.939375303067, 11988.100892432927, 12095.697607559881, 12174.634760957186, 12312.876871231172, 12328.260304381765, 8567.314614830922, 8712.825743484967, 8782.385233033627, 8826.205641492297, 8928.598213080297, 10936.45317734126, 11562.653120406401, 11672.182947193614, 11777.411129443664, 11859.22915010556], "value": 9124.39952452063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.197394393999, 1528.182422404014, 1722.2594284457687, 1846.769153855768, 1864.6177533605612, 8073.0, 8591.226789588936, 8792.736217913456, 9335.299852511063, 9340.53297335133, 8830.558472076402, 8846.823063538724, 8925.0, 8941.239994600466, 8955.05971872952, 2316.652502124682, 2350.670906073151, 2351.1183306260154, 2351.1888398502488, 2356.893939772706, 2328.499372634883, 2345.144022431817, 2365.195833416638, 2368.8815559222057, 2374.548835721216, 2333.509962907783, 2346.542424227268, 2347.1784875293597, 2350.9177178798745, 2375.9881200593973, 2260.7739226077424, 2279.658051292319, 2283.3264187064856, 2289.6565515172692, 2332.6267797152373, 2283.8287128465267, 2309.6997390339316, 2313.1556981701724, 2321.3964369264113, 2327.7090363704538, 8845.778855528599, 8907.777305567348, 8940.955295223548, 8943.552822358855, 9013.774655633597, 5105.387353517564, 5191.480851914778, 5363.678179309254, 5376.623636345457, 5379.327584051994, 3234.4165515614245, 3270.280538281574, 3306.636270010297, 3326.3513614845115, 3355.79191491063, 1028.254515476281, 1041.7864337810806, 1063.0910571461366, 1077.9622713205079, 1093.3931667924298, 12724.1729287596, 12742.554010609585, 12752.0, 12758.553450629184, 12762.80855787164, 4635.258358662598, 4693.530646935279, 4699.130660827758, 4723.409573803275, 4872.074305881942, 10526.421046842344, 10594.735131621772, 10596.947015265028, 10612.151027917747, 10639.946800265949, 5485.341758988947, 5489.2589500417735, 5490.780368785284, 5496.862578435491, 5499.752511137009, 4329.740215587075, 4852.95147048525, 4909.4845041270155, 4988.825391111293, 4992.326035985168, 3979.621935916083, 3992.640662340403, 4072.266991941479, 4099.692523060723, 4123.36087906375, 1274.4137696659454, 1281.9423125959354, 1293.5084667826166, 1295.8315418995471, 1300.4083142170289, 879.8196369744187, 978.3298440568234, 1045.5295117197293, 1056.3239526702916, 1083.9566417343217, 6312.652804095727, 6369.076483909807, 6424.26120996082, 6438.163038805019, 6481.157449531531, 476.5496605707573, 477.3960939411647, 478.7989044601276, 486.03764546198727, 487.43214155508434, 4351.4995775485595, 4473.932891006638, 4475.910481790346, 4514.571115743999, 4520.932186017212, 11115.72210694739, 11593.826092608617, 11610.477528511237, 11638.6508404748, 11638.6508404748, 11264.155188360906, 11341.26281791681, 11350.318980861175, 11396.088312934946, 11408.201425900274, 7786.610669466618, 8134.796630084295, 8140.470869393471, 8287.549678806185, 8295.253427191581, 6278.121063051085, 6518.315576864551, 6582.80251592453, 6591.901121483277, 6649.936010238339, 10369.688909332732, 10565.313254638424, 10665.0, 10698.572057117939, 10710.410927399067, 10658.520366583367, 10688.038076573146, 10760.3543787373, 10850.131989440984, 10897.400642964712, 7261.3101755333155, 7288.380487658608, 7403.851922961403, 7941.0, 8083.0, 8572.142785721378, 8587.0, 8648.0, 8652.178043085896, 8661.826763464569, 7542.132654744774, 7783.766487005399, 7791.337736292478, 7839.608019598883, 7898.68405263783, 7557.35762460197, 7590.544567325978, 7656.885146722692, 7690.9232707422125, 7792.0, 7162.964185179041, 7170.641467926478, 7221.097362829646, 7250.0, 7266.091738532684, 5255.7123504741585, 5357.24998500218, 5469.671819690831, 5495.945040549704, 5498.80754173602, 5338.252644629677, 5395.81114660985, 5401.378841433286, 5417.674939503642, 5531.170324451365], "value": 4666.439243158389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.2396580019853, 332.8768355708388, 338.10571039600256, 339.8546896957253, 342.245349005443, 5412.539934105605, 5422.078246698061, 5425.2675888755, 5570.412432456751, 5575.665460072399, 5569.415211402805, 5578.191162281467, 5594.188842617828, 5601.075822489284, 5607.4112218217115, 4336.392904993303, 4383.276759334706, 4384.583464570861, 4395.791157431716, 4402.735835849843, 4127.793610319487, 4290.292101803198, 4290.399344091829, 4395.692301538894, 4405.933910991322, 4264.21112094262, 4294.527601963781, 4300.35494675798, 4301.118270754488, 4304.698671093025, 4270.14597080582, 4298.935515967263, 4309.758925358811, 4313.654907607384, 4315.4389929309145, 3597.388443964532, 3767.9811600942094, 3770.2082562661876, 3774.9433758493647, 3781.810909454516, 5343.171808369709, 5368.174820561028, 5398.973005134949, 5401.216823560561, 5403.486668766461, 4900.754962251909, 4927.531884470969, 4940.283658869444, 4946.3817022872145, 4954.423699676148, 5529.834104976857, 5816.858896196091, 5819.912701309484, 5835.416458354173, 5836.649801011953, 4063.3295506241434, 4096.201240758053, 4121.814518346681, 4141.7929103545, 4144.668426525871, 5980.28236611605, 5985.79759828494, 6000.279966404016, 6000.399960004008, 6052.910476114298, 4091.89770255746, 4160.2303573838935, 4170.748775367378, 4194.8112334945, 4240.363945408213, 4184.28867092595, 4187.43469631602, 4194.790260486963, 4206.558311377323, 4234.640055595309, 4845.0, 4879.219324908068, 4879.731269869789, 4884.511548845158, 4891.290762839369, 5239.607029472805, 5869.2956845178, 5870.207521984563, 5875.618084824473, 5919.6744179070565, 1472.821742605911, 1479.3416929466284, 1482.303317440801, 1488.2558720639681, 1489.4712377106189, 900.1268769293774, 924.1359329027381, 927.0173615967096, 934.6775362499926, 936.601944173737, 5031.496850315012, 5064.670796398223, 5100.744962751847, 5122.410922743858, 5135.948640513622, 5288.9735551322, 5302.496262855023, 5358.732063396815, 5365.382980957162, 5371.328583927009, 5018.623603229772, 5020.3724534433195, 5034.79860805571, 5217.50433708797, 5703.460065782298, 3207.374561960395, 3218.7585931055264, 3232.288896442779, 3240.513922911535, 3242.789218700777, 6109.327973922865, 6254.0, 6301.747930082837, 6315.873682526324, 6330.525210609223, 6113.541484388688, 6134.6625935573975, 6153.446189842935, 6156.78451254204, 6158.846028849314, 6132.264128304632, 6207.317195108534, 6231.345708700521, 6234.501239900797, 6236.844078897973, 5750.993576124245, 6011.106501452028, 6012.398760124128, 6049.576529642883, 6086.2087928569, 5888.911666325094, 5927.784804115232, 5934.821955341346, 5949.553783466171, 5987.6108052976415, 6005.669688167192, 6175.9382406177165, 6191.81424557264, 6225.408586184305, 6226.1905952225925, 4158.523724077909, 4187.9320773202635, 4190.895227619334, 4194.119234960693, 4207.789610519523, 5700.743466544099, 5912.73392697321, 5982.042873140276, 5998.130271110752, 6019.548533860066, 5844.327902291291, 5874.823755287348, 5877.147813566923, 5877.794277200277, 5892.6759028253855, 5711.200431939449, 5784.595078344475, 5814.476697097281, 5830.5627077968475, 5873.911891321548, 5527.270555563857, 5735.885282294247, 5777.3670671097025, 5779.306483222041, 5780.901628690535, 5864.237649105589, 5870.354261031369, 5874.295084589706, 5885.705714714333, 5899.351071382231, 5491.2312276282155, 5721.971390143022, 5730.914036289542, 5774.566907481872, 5832.387599302012], "value": 4388.132349948447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.3849235487753, 686.6017709728358, 688.359825362413, 702.3713776170327, 709.8935159726041, 14219.146851188923, 14232.0, 14271.928640356784, 14287.214203218831, 14352.641183970405, 13963.162210267366, 13966.511172108978, 14042.0, 14074.22591757453, 14087.0, 677.6543962579095, 783.5337973905517, 803.1245941923303, 806.173671986213, 807.8142027333716, 802.835418739157, 805.9556724380157, 808.2442915873647, 811.1928631012152, 813.9552324622143, 864.3042350907517, 866.0733015673233, 867.652938824469, 868.9522076285801, 871.4161511787117, 853.8377708235478, 854.5171977832536, 857.7641148684099, 858.394831643696, 864.0797550608613, 621.8227805075531, 622.8909940760349, 624.4567226512963, 630.0328994992665, 632.2034236861541, 14423.557644235598, 14451.0, 14459.638509037253, 14484.34820433083, 14497.202653854034, 13853.653658658513, 14975.550733478012, 14981.925090374478, 15129.924350378178, 15215.467458638894, 11384.658460246123, 11449.942750286194, 11472.139589530818, 11493.942530287295, 11979.221350612183, 3690.9052995323077, 3722.627737226283, 3873.98063009686, 3945.0531872350716, 3947.5657677655436, 75794.62102689451, 76476.23523764747, 76734.0, 77035.6148219261, 77405.22594774037, 10989.395583242998, 11654.708632284091, 11795.41022948849, 11844.526218951145, 11911.463984120735, 21052.78947210539, 21215.15139394407, 21254.78745212528, 21300.25449109274, 21568.460788480414, 8628.697995570124, 8818.206361427503, 8833.646654133763, 8919.331050171264, 8974.775630609287, 4520.954790452053, 4589.632829373709, 4612.584867361954, 4634.467036290802, 4658.161530924398, 3587.856485740593, 3681.502997095358, 3691.53855768029, 3695.4826324314618, 3717.126475278307, 679.6228093408107, 686.193722376206, 686.3548264631231, 694.9548279361825, 696.6342670098239, 715.713714514188, 738.5974643819131, 752.5033477904557, 753.5252790741797, 773.6054612147846, 10105.898941010495, 10133.746656333651, 10133.797324053625, 10188.592456301665, 10298.17614590831, 729.2889432803081, 737.5433518800327, 759.810047488128, 762.9008228930204, 763.6029264782283, 4684.414448193976, 4720.221163507983, 4737.95262047382, 4924.0, 4962.404511458576, 84630.0, 107435.0, 113181.0, 116165.4191729036, 118298.0, 97266.0, 97672.0, 99000.0, 99328.50335748275, 100680.0, 85817.57091214503, 86886.56556717302, 87188.56405718057, 87770.12229877747, 88641.11358886458, 8898.822023559622, 8979.46123232608, 9151.63393464254, 9382.390144640576, 9388.257970928084, 50833.74583127061, 51759.0, 52482.21276680777, 52641.0, 52803.73598131985, 66847.33152668411, 67388.3261167382, 74217.88673169799, 76783.61608192147, 77551.2244877544, 11453.713657158638, 11570.074394048625, 11775.646730598095, 12082.33547154915, 12285.262884226617, 11952.46213920393, 12286.139970202, 12330.75338493243, 12788.936055319664, 12811.871881281068, 11766.82349764737, 12078.335691536699, 12177.0, 12638.304893230961, 12882.613521594367, 10946.39794811293, 10983.725406864893, 11578.884211157781, 12276.87723122793, 12281.631551053482, 11670.474828632561, 11731.178817482694, 11962.940185299018, 12005.219660722025, 12258.938705306417, 9470.242380609672, 9552.087626178574, 9639.18066964316, 9755.17684983268, 9770.0, 9428.764280892758, 9467.526623668928, 9696.563654635418, 9835.311528193244, 9910.405375677483], "value": 7352.166219940139, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 159.0, 181.0, 133.0, 160.0, 163.0, 131.0, 185.0, 126.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 162.0, 162.0, 165.0, 168.0, 160.0, 163.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 158.0, 76.0, 77.0, 75.0, 92.0, 158.0, 80.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 148.0, 84.0, 84.0, 84.0, 142.0, 84.0, 84.0, 136.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 121.0, 118.0, 119.0, 118.0, 121.0, 117.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 97.0, 96.0, 100.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 58.0, 55.0, 60.0, 53.0, 58.0, 54.0, 56.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 59.0, 60.0, 61.0, 60.0, 61.0, 62.0, 61.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 79.0, 83.0, 80.0, 82.0, 81.0, 81.0, 121.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 124.0, 126.0, 133.0, 129.0, 132.0, 130.0, 132.0, 142.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 166.0, 164.0, 163.0, 162.0, 160.0, 160.0, 165.0, 157.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0], "value": 63.4, "unit": "score"}]}]} 04:52:33 INFO - Return code: 0 04:52:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:33 ERROR - # TBPL SUCCESS # 04:52:33 INFO - Running post-action listener: _resource_record_post_action 04:52:33 INFO - ##### 04:52:33 INFO - ##### Finished run-tests step (success) 04:52:33 INFO - ##### 04:52:33 INFO - Running post-run listener: _resource_record_post_run 04:52:33 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 553132032; Read time: 0; Write time: 400556 04:52:33 INFO - TinderboxPrint: CPU usage
13.5% 04:52:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:52:33 INFO - TinderboxPrint: I/O write bytes / time
553,132,032 / 400,556 04:52:33 INFO - TinderboxPrint: CPU idle
8,221.0 (86.5%) 04:52:33 INFO - TinderboxPrint: CPU user
1,223.5 (12.9%) 04:52:33 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 223260672; Read time: 0; Write time: 213284 04:52:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291254272; Read time: 0; Write time: 168344 04:52:33 INFO - Running post-run listener: _upload_blobber_files 04:52:33 INFO - Blob upload gear active. 04:52:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:33 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:33 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:39 INFO - (blobuploader) - INFO - Done attempting. 04:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:39 INFO - (blobuploader) - INFO - Done attempting. 04:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:40 INFO - (blobuploader) - INFO - Done attempting. 04:52:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:40 INFO - Return code: 0 04:52:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc26c45bede06c8ee4e41a46dabf93770ea42b8a281525fbf4d8f906796bf2949254020975d7f792059659dc827a62f385b9cf42e166af921bb8b3c15e97117e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6a7f932428bce0957081d3a3457beb22f67e3779120d79f52575d58081342ae841e9032a3f13f2cea35da19e8aca84c3f78edffdc9110e7c0801544c7f3629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b29e7ab629a9f08b1187a7eb9550d5944379b13dc72af75d16e2a2a4ba401358dbcf5c94af980f7e6477028751d8f5838e49ef5352cd7e65b1ed67487a48f9a7"} 04:52:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:40 INFO - Contents: 04:52:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc26c45bede06c8ee4e41a46dabf93770ea42b8a281525fbf4d8f906796bf2949254020975d7f792059659dc827a62f385b9cf42e166af921bb8b3c15e97117e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6a7f932428bce0957081d3a3457beb22f67e3779120d79f52575d58081342ae841e9032a3f13f2cea35da19e8aca84c3f78edffdc9110e7c0801544c7f3629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b29e7ab629a9f08b1187a7eb9550d5944379b13dc72af75d16e2a2a4ba401358dbcf5c94af980f7e6477028751d8f5838e49ef5352cd7e65b1ed67487a48f9a7"} 04:52:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:40 INFO - Copying logs to upload dir... 04:52:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.472703 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 04:52:40.247550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 04:52:40.251119) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc26c45bede06c8ee4e41a46dabf93770ea42b8a281525fbf4d8f906796bf2949254020975d7f792059659dc827a62f385b9cf42e166af921bb8b3c15e97117e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6a7f932428bce0957081d3a3457beb22f67e3779120d79f52575d58081342ae841e9032a3f13f2cea35da19e8aca84c3f78edffdc9110e7c0801544c7f3629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b29e7ab629a9f08b1187a7eb9550d5944379b13dc72af75d16e2a2a4ba401358dbcf5c94af980f7e6477028751d8f5838e49ef5352cd7e65b1ed67487a48f9a7"} build_url:https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/WbJouRCFQX6lMLseSc8NAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc26c45bede06c8ee4e41a46dabf93770ea42b8a281525fbf4d8f906796bf2949254020975d7f792059659dc827a62f385b9cf42e166af921bb8b3c15e97117e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6a7f932428bce0957081d3a3457beb22f67e3779120d79f52575d58081342ae841e9032a3f13f2cea35da19e8aca84c3f78edffdc9110e7c0801544c7f3629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b29e7ab629a9f08b1187a7eb9550d5944379b13dc72af75d16e2a2a4ba401358dbcf5c94af980f7e6477028751d8f5838e49ef5352cd7e65b1ed67487a48f9a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 04:52:40.277171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:52:40.277579) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464867125.586832-1242615207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:52:40.361187) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 04:52:40.361569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 04:52:40.361889) ========= ========= Total master_lag: 0.17 =========