builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1464832832.81 results: success (0) buildid: 20160601163037 builduid: 4f596a0e8a4e45f5a0d86f7b4fd53175 revision: 23fde8ecfa91aeaa071bb19165a999b8606008f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:32.808480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:32.809000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:32.809316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:32.824640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:32.824936) ========= 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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 19:00:33-- 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% 217M=0s 2016-06-01 19:00:33 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.002172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.002515) ========= 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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.053132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.053495) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 23fde8ecfa91aeaa071bb19165a999b8606008f1 --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 23fde8ecfa91aeaa071bb19165a999b8606008f1 --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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 19:00:33,279 truncating revision to first 12 chars 2016-06-01 19:00:33,279 Setting DEBUG logging. 2016-06-01 19:00:33,279 attempt 1/10 2016-06-01 19:00:33,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/23fde8ecfa91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 19:00:33,625 unpacking tar archive at: mozilla-inbound-23fde8ecfa91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.741285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.741668) ========= script_repo_revision: 23fde8ecfa91aeaa071bb19165a999b8606008f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.742100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.742383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:00:33.751244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-01 19:00:33.751625) ========= /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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:34 INFO - MultiFileLogger online at 20160601 19:00:34 in /builds/slave/test 19:00:34 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 19:00:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:34 INFO - {'append_to_log': False, 19:00:34 INFO - 'base_work_dir': '/builds/slave/test', 19:00:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:00:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:34 INFO - 'branch': 'Mozilla-Inbound', 19:00:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:34 INFO - 'config_files': ('talos/linux_config.py',), 19:00:34 INFO - 'default_actions': ('clobber', 19:00:34 INFO - 'read-buildbot-config', 19:00:34 INFO - 'download-and-extract', 19:00:34 INFO - 'populate-webroot', 19:00:34 INFO - 'create-virtualenv', 19:00:34 INFO - 'install', 19:00:34 INFO - 'run-tests'), 19:00:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:34 INFO - 'download_minidump_stackwalk': True, 19:00:34 INFO - 'download_symbols': 'ondemand', 19:00:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:34 INFO - 'installer_path': 'installer.exe', 19:00:34 INFO - 'log_level': 'info', 19:00:34 INFO - 'log_name': 'talos', 19:00:34 INFO - 'log_to_console': True, 19:00:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:34 INFO - 'opt_config_files': (), 19:00:34 INFO - 'pip_index': False, 19:00:34 INFO - 'sps_profile': False, 19:00:34 INFO - 'sps_profile_interval': 0, 19:00:34 INFO - 'suite': 'dromaeojs-e10s', 19:00:34 INFO - 'system_bits': '32', 19:00:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:34 INFO - 'title': 'talos-linux64-ix-031', 19:00:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:34 INFO - 'use_talos_json': True, 19:00:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:34 INFO - 'work_dir': 'build'} 19:00:34 INFO - ##### 19:00:34 INFO - ##### Running clobber step. 19:00:34 INFO - ##### 19:00:34 INFO - Running pre-action listener: _resource_record_pre_action 19:00:34 INFO - Running main action method: clobber 19:00:34 INFO - rmtree: /builds/slave/test/build 19:00:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:35 INFO - Running post-action listener: _resource_record_post_action 19:00:35 INFO - ##### 19:00:35 INFO - ##### Finished clobber step (success) 19:00:35 INFO - ##### 19:00:35 INFO - ##### 19:00:35 INFO - ##### Running read-buildbot-config step. 19:00:35 INFO - ##### 19:00:35 INFO - Running pre-action listener: _resource_record_pre_action 19:00:35 INFO - Running main action method: read_buildbot_config 19:00:35 INFO - Using buildbot properties: 19:00:35 INFO - { 19:00:35 INFO - "project": "", 19:00:35 INFO - "product": "firefox", 19:00:35 INFO - "script_repo_revision": "production", 19:00:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:00:35 INFO - "repository": "", 19:00:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:00:35 INFO - "buildid": "20160601163037", 19:00:35 INFO - "pgo_build": "True", 19:00:35 INFO - "basedir": "/builds/slave/test", 19:00:35 INFO - "buildnumber": 777, 19:00:35 INFO - "slavename": "talos-linux64-ix-031", 19:00:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:00:35 INFO - "platform": "ubuntu64_hw", 19:00:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:00:35 INFO - "branch": "mozilla-inbound", 19:00:35 INFO - "repo_path": "integration/mozilla-inbound", 19:00:35 INFO - "revision": "23fde8ecfa91aeaa071bb19165a999b8606008f1", 19:00:35 INFO - "stage_platform": "linux64-pgo", 19:00:35 INFO - "builduid": "4f596a0e8a4e45f5a0d86f7b4fd53175", 19:00:35 INFO - "slavebuilddir": "test" 19:00:35 INFO - } 19:00:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:00:35 INFO - Running post-action listener: _resource_record_post_action 19:00:35 INFO - ##### 19:00:35 INFO - ##### Finished read-buildbot-config step (success) 19:00:35 INFO - ##### 19:00:35 INFO - ##### 19:00:35 INFO - ##### Running download-and-extract step. 19:00:35 INFO - ##### 19:00:35 INFO - Running pre-action listener: _resource_record_pre_action 19:00:35 INFO - Running main action method: download_and_extract 19:00:35 INFO - mkdir: /builds/slave/test/build/tests 19:00: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')]} 19:00:35 INFO - https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:36 INFO - Downloaded 1361 bytes. 19:00:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:00:36 INFO - Using the following test package requirements: 19:00:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:00:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'jsshell-linux-x86_64.zip'], 19:00:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00: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')]} 19:00:36 INFO - https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:38 INFO - Downloaded 24423222 bytes. 19:00:38 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'] 19:00:38 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 19:00:40 INFO - Return code: 0 19:00:40 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 19:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:40 INFO - https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:42 INFO - Downloaded 24423222 bytes. 19:00:42 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'] 19:00:42 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 19:00:43 INFO - Return code: 0 19:00:43 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')]} 19:00:43 INFO - https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:44 INFO - Downloaded 10834055 bytes. 19:00:44 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'] 19:00:44 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 19:00:44 INFO - Return code: 0 19:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:44 INFO - https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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 19:00:46 INFO - Downloaded 59068233 bytes. 19:00:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:00:46 INFO - mkdir: /builds/slave/test/properties 19:00:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:46 INFO - Contents: 19:00:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - Running post-action listener: set_extra_try_arguments 19:00:47 INFO - ##### 19:00:47 INFO - ##### Finished download-and-extract step (success) 19:00:47 INFO - ##### 19:00:47 INFO - ##### 19:00:47 INFO - ##### Running populate-webroot step. 19:00:47 INFO - ##### 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: populate_webroot 19:00:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:47 INFO - '--tppagecycles', 19:00:47 INFO - '7'], 19:00:47 INFO - 'tests': ['tsvgm']}}, 19:00:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['damp', 'tps']}, 19:00:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['damp', 'tps']}, 19:00:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['dromaeo_dom']}, 19:00:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['a11yr', 19:00:47 INFO - 'ts_paint', 19:00:47 INFO - 'tpaint', 19:00:47 INFO - 'sessionrestore', 19:00:47 INFO - 'sessionrestore_no_auto_restore', 19:00:47 INFO - 'tabpaint']}, 19:00:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tsvgx', 19:00:47 INFO - 'tsvgr_opacity', 19:00:47 INFO - 'tart', 19:00:47 INFO - 'tscrollx', 19:00:47 INFO - 'cart']}, 19:00:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:47 INFO - 'tsvgr_opacity', 19:00:47 INFO - 'tart', 19:00:47 INFO - 'tscrollx', 19:00:47 INFO - 'cart']}, 19:00:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s'], 19:00:47 INFO - 'tests': ['tp5o']}, 19:00:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'tests': ['tp5o']}, 19:00:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--disable-e10s', 19:00:47 INFO - '--xperf_path', 19:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:47 INFO - 'tests': ['tp5n']}, 19:00:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:47 INFO - 'talos_options': ['--xperf_path', 19:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:47 INFO - 'tests': ['tp5n']}}, 19:00:47 INFO - 'talos.zip': {'path': '', 19:00:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - ##### 19:00:47 INFO - ##### Finished populate-webroot step (success) 19:00:47 INFO - ##### 19:00:47 INFO - ##### 19:00:47 INFO - ##### Running create-virtualenv step. 19:00:47 INFO - ##### 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: create_virtualenv 19:00:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:47 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 19:00:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:47 INFO - Using real prefix '/usr' 19:00:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:49 INFO - Installing pip.................done. 19:00:49 INFO - Return code: 0 19:00:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:49 INFO - Using env: {'DISPLAY': ':0', 19:00:49 INFO - 'HOME': '/home/cltbld', 19:00:49 INFO - 'LANG': 'en_US.UTF-8', 19:00:49 INFO - 'LANGUAGE': 'en_US:en', 19:00:49 INFO - 'LOGNAME': 'cltbld', 19:00:49 INFO - 'MAIL': '/var/mail/cltbld', 19:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:49 INFO - 'MOZ_NO_REMOTE': '1', 19:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:49 INFO - 'NO_EM_RESTART': '1', 19:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:49 INFO - 'PWD': '/builds/slave/test', 19:00:49 INFO - 'SHELL': '/bin/bash', 19:00:49 INFO - 'SHLVL': '1', 19:00:49 INFO - 'TERM': 'linux', 19:00:49 INFO - 'TMOUT': '86400', 19:00:49 INFO - 'USER': 'cltbld', 19:00:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:49 INFO - '_': '/tools/buildbot/bin/python'} 19:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:00:49 INFO - Cleaning up... 19:00:49 INFO - Return code: 0 19:00:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:00:49 INFO - Using env: {'DISPLAY': ':0', 19:00:49 INFO - 'HOME': '/home/cltbld', 19:00:49 INFO - 'LANG': 'en_US.UTF-8', 19:00:49 INFO - 'LANGUAGE': 'en_US:en', 19:00:49 INFO - 'LOGNAME': 'cltbld', 19:00:49 INFO - 'MAIL': '/var/mail/cltbld', 19:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:49 INFO - 'MOZ_NO_REMOTE': '1', 19:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:49 INFO - 'NO_EM_RESTART': '1', 19:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:49 INFO - 'PWD': '/builds/slave/test', 19:00:49 INFO - 'SHELL': '/bin/bash', 19:00:49 INFO - 'SHLVL': '1', 19:00:49 INFO - 'TERM': 'linux', 19:00:49 INFO - 'TMOUT': '86400', 19:00:49 INFO - 'USER': 'cltbld', 19:00:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:49 INFO - '_': '/tools/buildbot/bin/python'} 19:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:50 INFO - Downloading/unpacking psutil>=3.1.1 19:00:50 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 19:00:50 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 19:00:50 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 19:00:50 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 19:00:50 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 19:00:50 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 19:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:52 INFO - Installing collected packages: psutil 19:00:52 INFO - Running setup.py install for psutil 19:00:52 INFO - building 'psutil._psutil_linux' extension 19:00:52 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 19:00:52 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 19:00:52 INFO - building 'psutil._psutil_posix' extension 19:00:52 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 19:00:52 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 19:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:52 INFO - Successfully installed psutil 19:00:52 INFO - Cleaning up... 19:00:52 INFO - Return code: 0 19:00:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:00:52 INFO - Using env: {'DISPLAY': ':0', 19:00:52 INFO - 'HOME': '/home/cltbld', 19:00:52 INFO - 'LANG': 'en_US.UTF-8', 19:00:52 INFO - 'LANGUAGE': 'en_US:en', 19:00:52 INFO - 'LOGNAME': 'cltbld', 19:00:52 INFO - 'MAIL': '/var/mail/cltbld', 19:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:52 INFO - 'MOZ_NO_REMOTE': '1', 19:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:52 INFO - 'NO_EM_RESTART': '1', 19:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:52 INFO - 'PWD': '/builds/slave/test', 19:00:52 INFO - 'SHELL': '/bin/bash', 19:00:52 INFO - 'SHLVL': '1', 19:00:52 INFO - 'TERM': 'linux', 19:00:52 INFO - 'TMOUT': '86400', 19:00:52 INFO - 'USER': 'cltbld', 19:00:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:52 INFO - '_': '/tools/buildbot/bin/python'} 19:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:54 INFO - Installing collected packages: mozsystemmonitor 19:00:54 INFO - Running setup.py install for mozsystemmonitor 19:00:54 INFO - Successfully installed mozsystemmonitor 19:00:54 INFO - Cleaning up... 19:00:54 INFO - Return code: 0 19:00:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:54 INFO - Using env: {'DISPLAY': ':0', 19:00:54 INFO - 'HOME': '/home/cltbld', 19:00:54 INFO - 'LANG': 'en_US.UTF-8', 19:00:54 INFO - 'LANGUAGE': 'en_US:en', 19:00:54 INFO - 'LOGNAME': 'cltbld', 19:00:54 INFO - 'MAIL': '/var/mail/cltbld', 19:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:54 INFO - 'MOZ_NO_REMOTE': '1', 19:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:54 INFO - 'NO_EM_RESTART': '1', 19:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:54 INFO - 'PWD': '/builds/slave/test', 19:00:54 INFO - 'SHELL': '/bin/bash', 19:00:54 INFO - 'SHLVL': '1', 19:00:54 INFO - 'TERM': 'linux', 19:00:54 INFO - 'TMOUT': '86400', 19:00:54 INFO - 'USER': 'cltbld', 19:00:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:54 INFO - '_': '/tools/buildbot/bin/python'} 19:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 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 19:00:57 INFO - Downloading docopt-0.6.1.tar.gz 19:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:57 INFO - Running setup.py install for blobuploader 19:00:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:57 INFO - Running setup.py install for requests 19:00:58 INFO - Running setup.py install for docopt 19:00:58 INFO - Successfully installed blobuploader requests docopt 19:00:58 INFO - Cleaning up... 19:00:58 INFO - Return code: 0 19:00:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:58 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 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:00:58 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 19:00:58 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 19:00:58 INFO - Using env: {'DISPLAY': ':0', 19:00:58 INFO - 'HOME': '/home/cltbld', 19:00:58 INFO - 'LANG': 'en_US.UTF-8', 19:00:58 INFO - 'LANGUAGE': 'en_US:en', 19:00:58 INFO - 'LOGNAME': 'cltbld', 19:00:58 INFO - 'MAIL': '/var/mail/cltbld', 19:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:58 INFO - 'MOZ_NO_REMOTE': '1', 19:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:58 INFO - 'NO_EM_RESTART': '1', 19:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:58 INFO - 'PWD': '/builds/slave/test', 19:00:58 INFO - 'SHELL': '/bin/bash', 19:00:58 INFO - 'SHLVL': '1', 19:00:58 INFO - 'TERM': 'linux', 19:00:58 INFO - 'TMOUT': '86400', 19:00:58 INFO - 'USER': 'cltbld', 19:00:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:58 INFO - '_': '/tools/buildbot/bin/python'} 19:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:58 INFO - Running setup.py (path:/tmp/pip-RYCH9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:58 INFO - Running setup.py (path:/tmp/pip-OV8mYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:58 INFO - Running setup.py (path:/tmp/pip-nRNmtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:58 INFO - Running setup.py (path:/tmp/pip-OJ7TdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:58 INFO - Running setup.py (path:/tmp/pip-7NDfIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:58 INFO - Running setup.py (path:/tmp/pip-Pp_9Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:59 INFO - Running setup.py (path:/tmp/pip-xDwK6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:59 INFO - Running setup.py (path:/tmp/pip-pUXxLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:59 INFO - Running setup.py (path:/tmp/pip-qra6xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:59 INFO - Running setup.py (path:/tmp/pip-A42RZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:59 INFO - Running setup.py (path:/tmp/pip-InVVv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:59 INFO - Running setup.py (path:/tmp/pip-JqeegL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:59 INFO - Running setup.py (path:/tmp/pip-YGWca5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:59 INFO - Running setup.py (path:/tmp/pip-ezHKLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:59 INFO - Running setup.py (path:/tmp/pip-Prwonv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:59 INFO - Running setup.py (path:/tmp/pip-qdSAyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:59 INFO - Running setup.py (path:/tmp/pip-6uTY_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:59 INFO - Running setup.py install for manifestparser 19:00:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:59 INFO - Running setup.py install for mozcrash 19:00:59 INFO - Running setup.py install for mozdebug 19:01:00 INFO - Running setup.py install for mozdevice 19:01:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for mozfile 19:01:00 INFO - Running setup.py install for mozhttpd 19:01:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for mozinfo 19:01:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for mozInstall 19:01:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for mozleak 19:01:00 INFO - Running setup.py install for mozlog 19:01:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for moznetwork 19:01:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:01:00 INFO - Running setup.py install for mozprocess 19:01:01 INFO - Running setup.py install for mozprofile 19:01:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:01:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:01:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:01:01 INFO - Running setup.py install for mozrunner 19:01:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:01:01 INFO - Running setup.py install for mozscreenshot 19:01:01 INFO - Running setup.py install for moztest 19:01:01 INFO - Running setup.py install for mozversion 19:01:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:01:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:01 INFO - Cleaning up... 19:01:01 INFO - Return code: 0 19:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:01 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')]} 19:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:01 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')]} 19:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:01 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 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:01:01 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 19:01:01 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 19:01:01 INFO - Using env: {'DISPLAY': ':0', 19:01:01 INFO - 'HOME': '/home/cltbld', 19:01:01 INFO - 'LANG': 'en_US.UTF-8', 19:01:01 INFO - 'LANGUAGE': 'en_US:en', 19:01:01 INFO - 'LOGNAME': 'cltbld', 19:01:01 INFO - 'MAIL': '/var/mail/cltbld', 19:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:01 INFO - 'MOZ_NO_REMOTE': '1', 19:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:01 INFO - 'NO_EM_RESTART': '1', 19:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:01 INFO - 'PWD': '/builds/slave/test', 19:01:01 INFO - 'SHELL': '/bin/bash', 19:01:01 INFO - 'SHLVL': '1', 19:01:01 INFO - 'TERM': 'linux', 19:01:01 INFO - 'TMOUT': '86400', 19:01:01 INFO - 'USER': 'cltbld', 19:01:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:01 INFO - '_': '/tools/buildbot/bin/python'} 19:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:01 INFO - Running setup.py (path:/tmp/pip-z0ukgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:01 INFO - Running setup.py (path:/tmp/pip-4sZmkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:01 INFO - Running setup.py (path:/tmp/pip-uh3i2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:02 INFO - Running setup.py (path:/tmp/pip-ArcLXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:02 INFO - Running setup.py (path:/tmp/pip-LVWo3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:02 INFO - Running setup.py (path:/tmp/pip-fdGfh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:02 INFO - Running setup.py (path:/tmp/pip-3r_Rh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:02 INFO - Running setup.py (path:/tmp/pip-9mI_pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:02 INFO - Running setup.py (path:/tmp/pip-2zYQhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:02 INFO - Running setup.py (path:/tmp/pip-K0r8wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:02 INFO - Running setup.py (path:/tmp/pip-r8BsTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:02 INFO - Running setup.py (path:/tmp/pip-BVFTNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:02 INFO - Running setup.py (path:/tmp/pip-M8ux7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:02 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)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:02 INFO - Running setup.py (path:/tmp/pip-kbzsH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:02 INFO - Running setup.py (path:/tmp/pip-vAVSNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:02 INFO - Running setup.py (path:/tmp/pip-k3Lkaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:02 INFO - Running setup.py (path:/tmp/pip-UlI3VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:03 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)) 19:01:03 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)) 19:01:03 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)) 19:01:03 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)) 19:01:03 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)) 19:01:03 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)) 19:01:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:04 INFO - Downloading blessings-1.6.tar.gz 19:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:04 INFO - Installing collected packages: blessings 19:01:04 INFO - Running setup.py install for blessings 19:01:05 INFO - Successfully installed blessings 19:01:05 INFO - Cleaning up... 19:01:05 INFO - Return code: 0 19:01:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:05 INFO - Reading from file tmpfile_stdout 19:01:05 INFO - Current package versions: 19:01:05 INFO - argparse == 1.2.1 19:01:05 INFO - blessings == 1.6 19:01:05 INFO - blobuploader == 1.2.4 19:01:05 INFO - docopt == 0.6.1 19:01:05 INFO - manifestparser == 1.1 19:01:05 INFO - mozInstall == 1.12 19:01:05 INFO - mozcrash == 0.17 19:01:05 INFO - mozdebug == 0.1 19:01:05 INFO - mozdevice == 0.48 19:01:05 INFO - mozfile == 1.2 19:01:05 INFO - mozhttpd == 0.7 19:01:05 INFO - mozinfo == 0.9 19:01:05 INFO - mozleak == 0.1 19:01:05 INFO - mozlog == 3.2 19:01:05 INFO - moznetwork == 0.27 19:01:05 INFO - mozprocess == 0.22 19:01:05 INFO - mozprofile == 0.28 19:01:05 INFO - mozrunner == 6.11 19:01:05 INFO - mozscreenshot == 0.1 19:01:05 INFO - mozsystemmonitor == 0.3 19:01:05 INFO - moztest == 0.7 19:01:05 INFO - mozversion == 1.4 19:01:05 INFO - psutil == 3.1.1 19:01:05 INFO - requests == 1.2.3 19:01:05 INFO - wsgiref == 0.1.2 19:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:05 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 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:01:05 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 19:01:05 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 19:01:05 INFO - Using env: {'DISPLAY': ':0', 19:01:05 INFO - 'HOME': '/home/cltbld', 19:01:05 INFO - 'LANG': 'en_US.UTF-8', 19:01:05 INFO - 'LANGUAGE': 'en_US:en', 19:01:05 INFO - 'LOGNAME': 'cltbld', 19:01:05 INFO - 'MAIL': '/var/mail/cltbld', 19:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:05 INFO - 'MOZ_NO_REMOTE': '1', 19:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:05 INFO - 'NO_EM_RESTART': '1', 19:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:05 INFO - 'PWD': '/builds/slave/test', 19:01:05 INFO - 'SHELL': '/bin/bash', 19:01:05 INFO - 'SHLVL': '1', 19:01:05 INFO - 'TERM': 'linux', 19:01:05 INFO - 'TMOUT': '86400', 19:01:05 INFO - 'USER': 'cltbld', 19:01:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:05 INFO - '_': '/tools/buildbot/bin/python'} 19:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 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)) 19:01:05 INFO - Cleaning up... 19:01:05 INFO - Return code: 0 19:01:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:01:05 INFO - Using env: {'DISPLAY': ':0', 19:01:05 INFO - 'HOME': '/home/cltbld', 19:01:05 INFO - 'LANG': 'en_US.UTF-8', 19:01:05 INFO - 'LANGUAGE': 'en_US:en', 19:01:05 INFO - 'LOGNAME': 'cltbld', 19:01:05 INFO - 'MAIL': '/var/mail/cltbld', 19:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:05 INFO - 'MOZ_NO_REMOTE': '1', 19:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:05 INFO - 'NO_EM_RESTART': '1', 19:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:05 INFO - 'PWD': '/builds/slave/test', 19:01:05 INFO - 'SHELL': '/bin/bash', 19:01:05 INFO - 'SHLVL': '1', 19:01:05 INFO - 'TERM': 'linux', 19:01:05 INFO - 'TMOUT': '86400', 19:01:05 INFO - 'USER': 'cltbld', 19:01:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:05 INFO - '_': '/tools/buildbot/bin/python'} 19:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:05 INFO - Downloading/unpacking jsonschema 19:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:07 INFO - Downloading/unpacking functools32 (from jsonschema) 19:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:07 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:08 INFO - warning: no files found matching '*.txt' 19:01:08 INFO - no previously-included directories found matching 'build' 19:01:08 INFO - no previously-included directories found matching 'dist' 19:01:08 INFO - no previously-included directories found matching '.git*' 19:01:08 INFO - Installing collected packages: jsonschema, functools32 19:01:08 INFO - Running setup.py install for functools32 19:01:08 INFO - warning: no files found matching '*.txt' 19:01:08 INFO - no previously-included directories found matching 'build' 19:01:08 INFO - no previously-included directories found matching 'dist' 19:01:08 INFO - no previously-included directories found matching '.git*' 19:01:08 INFO - Successfully installed jsonschema functools32 19:01:08 INFO - Cleaning up... 19:01:08 INFO - Return code: 0 19:01:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd227d1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1503770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, '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': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', '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 19:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:01:08 INFO - Using env: {'DISPLAY': ':0', 19:01:08 INFO - 'HOME': '/home/cltbld', 19:01:08 INFO - 'LANG': 'en_US.UTF-8', 19:01:08 INFO - 'LANGUAGE': 'en_US:en', 19:01:08 INFO - 'LOGNAME': 'cltbld', 19:01:08 INFO - 'MAIL': '/var/mail/cltbld', 19:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:08 INFO - 'MOZ_NO_REMOTE': '1', 19:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:08 INFO - 'NO_EM_RESTART': '1', 19:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:08 INFO - 'PWD': '/builds/slave/test', 19:01:08 INFO - 'SHELL': '/bin/bash', 19:01:08 INFO - 'SHLVL': '1', 19:01:08 INFO - 'TERM': 'linux', 19:01:08 INFO - 'TMOUT': '86400', 19:01:08 INFO - 'USER': 'cltbld', 19:01:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:08 INFO - '_': '/tools/buildbot/bin/python'} 19:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:08 INFO - Downloading/unpacking flake8 19:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:01:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:01:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:01:11 INFO - no previously-included directories found matching 'docs/_build' 19:01:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:01:11 INFO - Running setup.py install for pep8 19:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:01:11 INFO - no previously-included directories found matching 'docs/_build' 19:01:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:01:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:01:11 INFO - Cleaning up... 19:01:11 INFO - Return code: 0 19:01:11 INFO - Running post-action listener: _resource_record_post_action 19:01:11 INFO - Running post-action listener: _start_resource_monitoring 19:01:11 INFO - Starting resource monitoring. 19:01:11 INFO - ##### 19:01:11 INFO - ##### Finished create-virtualenv step (success) 19:01:11 INFO - ##### 19:01:11 INFO - ##### 19:01:11 INFO - ##### Running install step. 19:01:11 INFO - ##### 19:01:11 INFO - Running pre-action listener: _resource_record_pre_action 19:01:11 INFO - Running main action method: install 19:01:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:11 INFO - Reading from file tmpfile_stdout 19:01:11 INFO - Detecting whether we're running mozinstall >=1.0... 19:01:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:01:11 INFO - Reading from file tmpfile_stdout 19:01:11 INFO - Output received: 19:01:11 INFO - Usage: mozinstall [options] installer 19:01:11 INFO - Options: 19:01:11 INFO - -h, --help show this help message and exit 19:01:11 INFO - -d DEST, --destination=DEST 19:01:11 INFO - Directory to install application into. [default: 19:01:11 INFO - "/builds/slave/test"] 19:01:11 INFO - --app=APP Application being installed. [default: firefox] 19:01:11 INFO - mkdir: /builds/slave/test/build/application 19:01:11 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'] 19:01:11 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 19:01:28 INFO - Reading from file tmpfile_stdout 19:01:28 INFO - Output received: 19:01:28 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:28 INFO - Running post-action listener: _resource_record_post_action 19:01:28 INFO - ##### 19:01:28 INFO - ##### Finished install step (success) 19:01:28 INFO - ##### 19:01:28 INFO - ##### 19:01:28 INFO - ##### Running run-tests step. 19:01:28 INFO - ##### 19:01:28 INFO - Running pre-action listener: _resource_record_pre_action 19:01:28 INFO - Running main action method: run_tests 19:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:28 INFO - Python 2.7.3 19:01:28 INFO - Return code: 0 19:01:28 INFO - grabbing minidump binary from tooltool 19:01: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')]} 19:01:28 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 0x15929c0>, '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 0x15938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1593d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:28 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 19:01:28 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 19:01:28 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 19:01:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:28 INFO - Return code: 0 19:01:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:01:29 INFO - Return code: 0 19:01:29 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/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:01:29 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/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:01:29 INFO - Using env: {'DISPLAY': ':0', 19:01:29 INFO - 'HOME': '/home/cltbld', 19:01:29 INFO - 'LANG': 'en_US.UTF-8', 19:01:29 INFO - 'LANGUAGE': 'en_US:en', 19:01:29 INFO - 'LOGNAME': 'cltbld', 19:01:29 INFO - 'MAIL': '/var/mail/cltbld', 19:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:29 INFO - 'MOZ_NO_REMOTE': '1', 19:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:29 INFO - 'NO_EM_RESTART': '1', 19:01:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:29 INFO - 'PWD': '/builds/slave/test', 19:01:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:29 INFO - 'SHELL': '/bin/bash', 19:01:29 INFO - 'SHLVL': '1', 19:01:29 INFO - 'TERM': 'linux', 19:01:29 INFO - 'TMOUT': '86400', 19:01:29 INFO - 'USER': 'cltbld', 19:01:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511', 19:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:29 INFO - '_': '/tools/buildbot/bin/python'} 19:01:29 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/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:01:29 INFO - mozversion application_buildid: 20160601163037 19:01:29 INFO - mozversion application_changeset: 23fde8ecfa91aeaa071bb19165a999b8606008f1 19:01:29 INFO - mozversion application_display_name: Nightly 19:01:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:29 INFO - mozversion application_name: Firefox 19:01:29 INFO - mozversion application_remotingname: firefox 19:01:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:01:29 INFO - mozversion application_vendor: Mozilla 19:01:29 INFO - mozversion application_version: 49.0a1 19:01:29 INFO - mozversion platform_buildid: 20160601163037 19:01:29 INFO - mozversion platform_changeset: 23fde8ecfa91aeaa071bb19165a999b8606008f1 19:01:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:01:29 INFO - mozversion platform_version: 49.0a1 19:01:29 INFO - using testdate: 1464832889 19:01:29 INFO - actual date: 1464832889 19:01:29 INFO - starting webserver on 'localhost:44900' 19:01:29 INFO - SUITE-START | Running 2 tests 19:01:29 INFO - TEST-START | dromaeo_css 19:01:29 INFO - operating with platform_type : linux_ 19:01:29 INFO - Initialising browser for dromaeo_css test... 19:01:29 INFO - TEST-INFO | started process 6842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW8PYyR/profile http://localhost:44900/getInfo.html) 19:01:34 INFO - PROCESS | 6842 | __metrics Screen width/height:1600/1200 19:01:34 INFO - PROCESS | 6842 | colorDepth:24 19:01:34 INFO - PROCESS | 6842 | Browser inner width/height: 1024/697 19:01:34 INFO - PROCESS | 6842 | __metrics 19:01:34 ERROR - PROCESS | 6842 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:01:35 INFO - TEST-INFO | 6842: exit 0 19:01:35 INFO - Browser initialized. 19:01:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:35 INFO - TEST-INFO | started process 6964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW8PYyR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:47 INFO - PROCESS | 6964 | RSS: Main: 167043072 19:01:47 INFO - PROCESS | 6964 | 19:02:37 INFO - PROCESS | 6964 | 1464832957200 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] 19:04:44 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44900/tests/dromaeo/cssquery-ext.html) 19:04:45 INFO - PROCESS | 6964 | RSS: Main: 170549248 19:04:45 INFO - PROCESS | 6964 | 19:07:47 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-ext.html (next: http://localhost:44900/tests/dromaeo/cssquery-jquery.html) 19:07:48 INFO - PROCESS | 6964 | RSS: Main: 169385984 19:07:48 INFO - PROCESS | 6964 | 19:10:50 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44900/tests/dromaeo/cssquery-mootools.html) 19:10:50 INFO - PROCESS | 6964 | RSS: Main: 170795008 19:10:50 INFO - PROCESS | 6964 | 19:13:52 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44900/tests/dromaeo/cssquery-prototype.html) 19:13:53 INFO - PROCESS | 6964 | RSS: Main: 168468480 19:13:53 INFO - PROCESS | 6964 | 19:16:55 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44900/tests/dromaeo/cssquery-yui.html) 19:16:56 INFO - PROCESS | 6964 | RSS: Main: 170442752 19:16:56 INFO - PROCESS | 6964 | 19:19:58 INFO - PROCESS | 6964 | Cycle 1(1): loaded http://localhost:44900/tests/dromaeo/cssquery-yui.html (next: http://localhost:44900/tests/dromaeo/cssquery-dojo.html) 19:19:59 INFO - PROCESS | 6964 | RSS: Main: 171388928 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | __start_tp_report 19:19:59 INFO - PROCESS | 6964 | _x_x_mozilla_page_load 19:19:59 INFO - PROCESS | 6964 | _x_x_mozilla_page_load_details 19:19:59 INFO - PROCESS | 6964 | |i|pagename|runs| 19:19:59 INFO - PROCESS | 6964 | |0;dojo.html;3102.612173478315;3140.3405284890173;3163.9050828475138;3176.237702951291;3184.920376990575;5420.485053919876;5459.727013649316;5490.313710786152;5525.530329921961;5540.778368865241;5397.568194544437;5403.756830942607;5499.3675727291375;5566.582506312023;5580.91628625571;5029.773660185291;5062.316587260728;5166.250893620423;5203.4536373680785;5216.60667717723;709.1396877072405;4907.803687852482;5059.848204553869;5075.6447048706605;5111.003354345904;5086.491350864921;5093.083245015896;5105.438401775802;5134.794608215667;5152.304438900756;5138.7656192346985;5170.146925757245;5173.224016397533;5175.301334319894;5201.9596080783995;4937.259411088366;4986.276989836453;5002.874928126789;5034.421041580192;5048.3941926969;5436.646617969819;5463.972680136613;5469.835904922858;5470.617056806025;5512.035393806108;5703.287089113861;5861.0915308127305;5904.380040095771;5907.704614769287;5978.940210597925;5941.465268125889;5969;5989.8203053908455;6052.757889684407;6056.242969628796;5555.944440555583;5614.803481878155;5615.66306021636;5625.634333768292;5639.492445679867;5865.061590145556;5895.557833162444;5901.380355062743;5915.704214789243;5915.881682366415;5838.562107841929;5881.676507792113;5886.117082437669;5902.144189092557;5903.409659034148;5981.790637327673;5995.790147344822;6002.759889604367;6006.039033754666;6023.427774361428;5655.717214139277;5792.073268277056;5885.146653735184;5954.910676339859;5986.3714309997695;5809.099589563624;5841.970790146022;5871.178035075093;5895.764169433261;5943.049112142036;4245.80893859777;4260.169266992907;4268.487781466244;4272.6795490338345;4278.144371125787;3727.1613886875234;3809.961900381016;3825.3305671507374;3827.3302172120325;3848.0764616491842;5579.7489112990015;5595.328560572757;5616.073347897633;5627.212190293362;5689.800856969986;5979.611325263931;6003.7898673546215;6007.3992600739575;6031.577789554689;6033.095035744585;5500.862478437991;5635.605507614428;5644.209810626516;5684.744186511617;5701.600887937804;4921.901561968741;4944.950550494521;4951.801927922915;4965.776540055706;5017.57350625201;6133.1413602095745;6171.259448866075;6183.072539119168;6193.349698281706;6211.503079753609;5828.591998560145;5898.233229680114;5925.466707996128;5948.37542058095;6038.909416358758;6163.19878415803;6167.722452489559;6173.135760993375;6184;6185.257769067741;5817.447342502455;5862.912056319074;5865.94134058654;5871.853203669772;5880.294364676266;5746;5755.1942728017275;5798.449147330997;5814.505767009682;5870.5010074142465;5647.209390685225;5726.79956201531;5731.627444216113;5743.798967036134;5749.741261643152;5601.747921343468;5684.772609095755;5703;5711;5724.141378793214;5625;5627.071533196977;5651.321841379061;5684.8294551163535;5698.430156984268;5776.624519406225;5787.884242315215;5818.359980402237;5821.534277257894;5843.240378750906;5440.265564148789;5700.173474846041;5714.742836572447;5715.342735585295;5803.8549036274435 19:19:59 INFO - PROCESS | 6964 | |1;ext.html;586.3374386942756;616.5468380740157;638.897901120567;647.1069923505562;661.2659947458318;39454.60545394545;43786.56213437865;44052.33921491172;44128;44145.7792711036;43367.566324336745;43652.345214821806;43960.780196098975;43992.34011489822;44033.899152521124;8700.608472618747;8876.644934202624;8881.777955551099;8894.955525222365;8919.063498332678;8803.911960880405;8831.514266715329;8884.511351875644;8889.599968001423;8890.066543012988;8888.644454221823;8938.687145949893;8942.597583108776;8945.463272203657;8946.3737538372;8843.071477494866;8857.114288571156;8870.467771933672;8889.822203555925;8914.465132092095;8810.295176385938;8909.465432074032;8911.777205569848;8913.509756963364;8919.554022298858;41497.585024149674;41666;41712;41806.581934180576;42185.1562968742;3289.3723766237085;3474.461458473915;3495.1961048958883;3535.3106144301873;3559.270349578356;32870.34259314824;33335.83332083324;34016.48975265373;34028;34104.317913641586;4250.298700714409;4272.359146128075;4284.571542845691;4428.911421771579;4450.198964186445;370686;373279;375224;378264;379186;64615.67692161603;64760.67619661872;65022.67488662527;65072.349276506626;65282.347176527626;65591.67204163948;67266.66366668136;67491.3250867485;67930.66034669794;67961.66019169873;16545.6690866182;16754.329826807036;16828.83171168297;16920.492385228463;16932.06873621938;12529.498820047278;12596.244225346509;12640.05199610033;12660.49358025687;12717.10980231375;20095.899520502597;20367.185312587626;20390;20511;20525.692114618294;6489;7134.429245660334;7168.354848063699;7234.855302893912;7491.438142139361;982.2485798364257;1002.318423472046;1043.4730461117088;1101.1796211822243;1132.0038366237823;33003.326706560336;33077.834610827274;33241.83379083138;33296.3340733184;33759.66240337614;1103.2167161315556;1106.8229083346787;1162.2677713040898;1167.2062997161843;1186.1874615888144;17064.48806535806;17428.651426971388;17602;18120.095053617282;18142.274309027754;602958;606568;607931;608690;608700;61570;63128.68435657792;63277.68361158165;63327;63951;1373.9106958047696;1382.3088455772113;1402.705431859321;1407.6480879780056;1410.9223992680295;32389.67610323961;32419.18952026218;33509;34541.48187777135;35362;59690.70154649199;60036.69981650238;60559.39440605538;60582;60639.39360606337;507390.5565666072;510345;510569;512789;512847;44917.550824491336;45037.77481112705;45047.73864338515;46434.767826160656;46728.532714673776;50818.491815081376;51108.74445627748;51725;52245.7387713059;52772.20841687454;42629.95015473525;43211.56788432076;43361;44125.33811992758;44529.55470445254;41735.58264417317;41974.370384443646;42237.155256894075;42400.78799605982;42460.363094554225;41534.79232603818;41867.371989419575;42794.35808462813;42902.14195716131;42944.570554294056;36813.63186368102;37640;38108.80945595254;38461.615383845805;38699.41950870683;28079.578806317513;28114.578281326205;28367.29081772972;28571.571426429036;28699.71300287054 19:19:59 INFO - PROCESS | 6964 | |2;jquery.html;392.8566073383216;396.3539430727913;398.4600865826804;406.21194881929057;413.14272883766193;13799.793003104962;18395.632087358263;19093.331733389336;19934.60130797385;19950.600987980233;17051.57371065721;17125.657486850254;17415.82584174158;18473.261069557237;18624.348147814828;5702.600817942745;5840.8247752567495;5853.09277062056;7014.508984371096;7439.4792364534505;7218.025566548527;7311.707531698752;7429.665665045059;7529.209433009537;7542.434317426188;7413.740519081834;7446.069241344832;7464.066991626047;7476.401887848959;7482.775516734507;7299.63501824912;7360.742374016911;7423.665935032936;7484;7499.725046742067;6953.478489113337;7144;7163.534370265916;7198.856022879566;7224.422046236341;24422.633660495107;24458.26625201229;25163.62254566183;26143.60784588233;26249.475010499875;2478.950420991588;2576.0726138590094;2813.6904940456534;3030.499967505359;3209.630892447375;15764.448244311508;16048.117353545551;16070.919645401815;16246.350145994145;16270.349186032545;2063.787079027573;2193.8025577698086;2203.10774136475;2219.3896678413403;2228.4985878177445;71387.64306178436;75277.49445011123;95741;101641;102598;16310.75533866993;17797.7330340045;17849.107544622977;18145.546361341072;18239.270429182685;32104.518432223536;32152.356952860813;32260.35479290401;32537.51193732096;32609.836950815094;9619.951900240454;9823.508824558743;9860.260480463994;9872.308938374244;9919.50402479873;8144.918550814535;8167.346612271004;8193.631286592117;8333.749987500385;8362.163783621589;8670.393072484992;8960.8655870162;8976.955115224513;9056.184943354998;9170.174684278314;3394.8302584870657;3416.1630400551526;3505.8948231553095;3527.7177825773874;3551.94672079919;940.8776859008285;1072.4316112460408;1082.410086502858;1092.6285063078592;1112.3826276416667;19114;19144;19194.232230710895;19334.80665193358;19671.114799834042;957.636098282662;1017.3641474078701;1028.6296933104077;1040.99479502602;1068.4497483795851;10434.16526677864;10775.299605525615;10863.239573229956;10912.508937097691;10967.561297548009;492885;499876;504699;505164;510487;100337;101927.49036254772;102277.48861255647;104448.47775761073;105127.47436262769;957.3155194036158;1003.3879333606494;1005.9396436213705;1030.0832259289239;1031.6440827914357;16034.919825400799;16678.66642667164;17089.658206836044;17195.312187512358;17548.91225543864;42261.57738422576;43283.783581081894;43494;43939.78030109957;44358.778206108764;55737.44262557485;58413;64129;64788.056358309324;65388;8036.357091432788;8039.316658083894;8157.592120394075;8256.380771442286;8330.250277475056;12553.184043037174;12670.429830657828;12919.354032298535;13296;13411.061225714106;11204.103671706082;11414.48634811419;11504.309741415542;11713.472893719974;11834.82247766267;11248;11258.831117533407;11296.830547541958;11689.181757276909;11844.70388240301;11475.426228688699;11915.582954596548;11941.582044628396;12108.334041627442;12216.083793715328;8216.794580135544;8330.750077497685;8474.533900635277;8486.61810218554;8502.74491765248;8481.06708262103;10844.60803820154;11953.880461195276;12290.938545307215;12403.379831008593 19:19:59 INFO - PROCESS | 6964 | |3;mootools.html;1447.4861424194407;1478.1869971515666;1598.7282162032454;1770.3007312111708;1817.9727304090434;7864.960675196616;8640.179182977616;8731.607077681503;9278.304127190453;9287;8760.693375731835;9006.189442950134;9041.683541076047;9066.501342426163;9091.909080909189;2350.0129945422923;2377.619580867062;2390.055927908475;2398.2565404724505;2400.1599440195964;2276.112316196676;2302.3898666853215;2303.79265866072;2306.9077236910503;2322.907083716658;2204.162418281051;2209.359285807114;2218.5673793610254;2241.1707668162803;2249.066637345508;2311.05246848792;2311.641695537194;2319.1535089692225;2324.988375058114;2342.847714898535;2301.1945818963395;2322.465832858435;2325.162941341116;2325.5348930213854;2344.871032093234;8991.865122023175;9039;9077.954610226907;9083.727488175366;9132.817343653156;5135.204043373245;5237.921431178535;5263.42102368743;5263.789448422059;5267.604929630293;3284.3871741084854;3389.5254664347012;3400.336934297813;3530.73519486037;3545.2554963457706;1090.3131027452732;1108.2076315434422;1119.7648493816228;1120.1724553727418;1141.7887690777234;12359.69100772488;12376.257424554555;12407.937960310232;12408.875911240862;12425.565105221274;4513.232750432434;4563.680542362069;4633.791479383436;4666.206744853315;4690.390249267573;10272.486375681186;10278.280520363503;10279.331843430302;10342;10386.480675966171;5089;5212.7228828936395;5212.947870521246;5215.374155101336;5218.556422704037;4228.281192197333;4696.060787842445;4751.952480475151;4831.033793241366;4838.975805120952;4062.2000009745652;4071.145059537471;4072.6538244249573;4154.189932963103;4185.748855068706;1246.7007918099591;1246.7755803955195;1247.289045244202;1264.525802823941;1294.1458637299525;803.2609998801117;888.1118881118881;918.6646873890982;934.514052692596;965.7006328038331;5631.690257035821;6103.1455596216565;6238.438540531283;6356.198867212039;6496.675166241669;928.7213835849218;980.3088822380205;991.5339790298548;1002.7844013536978;1026.5021464589668;3885.7668539887695;3893.435451859521;3945.072907866649;4004.8598299059395;4258.593641400404;11168.441577921072;11619.302841829349;11621.76756464866;11642.592509262135;11649.1263155262;11399.316041037564;11457.828132578017;11466.885331146748;11470.942645286721;11474.311541307548;8413.621387037598;8471.66113355459;8511.531865747444;8523.531205783742;8525.44584601999;5964.8807023860145;6104.38956104386;6202.596831205957;6373.6494492801485;6377.330380310186;10374;10397.11624511925;10526.894731052898;10575.524101415609;10619.840702389625;10105.494725263561;10549.78900421972;10806.081483074027;10829.404382758708;10836.241463097507;7790.9220907790195;8221.835563288581;8420.410571259952;8482.406231563979;8601.13988601135;8695.434796738191;8795.560221989002;8917.777055573662;8943.508107053915;8944.060873608438;7492.138404083382;7673.923260767321;7678.846423071619;7904.407169462198;7947.403944704286;7484.738034168778;7767.72812951544;7805.804854878674;8016.559089249914;8119.350451963947;6816.591004539743;6970;7007.8248043797275;7031.191412987572;7032.1912980007955;5005.324281221989;5220.973895130652;5407.864803379947;5435.211894275387;5471.425500322568;5248.186531087687;5393.083175860192;5412.83761487156;5473.425290344616;5566.944330556643 19:19:59 INFO - PROCESS | 6964 | |4;prototype.html;335.66768898790195;338.45508730943175;342.92969941162056;344.5589645254076;345.14576423352224;5489.533389661879;5634.77460901564;5663.451446848914;5702.173184888194;5710.942890571104;5459.617826752119;5571.860703482415;5580.358258800239;5620;5630.296212973379;4125.865387018572;4253.29820579604;4337.934930976022;4348.260795664744;4379.715318504287;4360.89097772555;4364.127174565084;4370.868873933771;4398.934015989763;4411.86764397067;4354.281543545327;4368.956310436887;4369.825206991716;4385.736855788663;4402.801873915681;4288.592583704559;4302.182585308781;4306.246406878784;4319.898425901407;4325.940144664546;3816.484774555455;3825.7321987460887;3842.1163132479687;3856.8071596420345;3861.5366156061173;5388.817528900801;5423.159410291411;5431.918521222185;5434.152388188035;5444.8366549003595;4828.637852161102;4974.228994505857;4988.7505624718615;4995.751062234442;5036.244563315532;5809.912851307234;5810.418958104198;5831.562632802556;5837.795677151279;5849.38581448946;4204.66362690984;4219.87340379786;4225.366195070733;4227.492700875914;4249.490061192646;5809.477147056785;6063.666498342589;6108.259146143372;6120.296165940929;6133.325334213233;4219.662427005832;4227.682923780729;4240.342746874239;4253.829846806093;4261.765602891871;4304.526502084768;4315.626405476975;4326.156399502067;4337.652987760972;4342.109867477159;4715.929261061086;4918.163912134945;4925.310456536088;4928.6303527235605;5002.1496345621335;5833.412451342394;5843.03589907669;5845.357010728816;5888.205092312569;5917.378675239124;1478.1943840606896;1486.435154641251;1498.887583431247;1501.4144483651385;1504.2553935801848;959.7696552827272;970.9514524273758;1006.7332156978407;1011.292095533115;1025.5333823110466;5711.743861174896;5756.769729210785;5761.88476230473;5761.962846687637;5779.537636989031;5834.795782147605;6025.367336429612;6077.392260773976;6083.847903802441;6084.84387966285;5530.5022547970075;5659.377468478464;5679.460451257124;5722.599418040781;5751.827445176651;3202.9679703203137;3240.9837950810097;3245.659205783406;3261.2662151015834;3272.181954511372;5981.401859813984;6208.161898143783;6217.96891015542;6220.25356957159;6283.874322513524;6086.60437071589;6091.472039103723;6105.9694701526205;6108.144859719554;6133.362654058708;5993.760249590055;6142.802153580009;6154.353792851686;6175.320714721377;6208.72060757267;5943.959807033838;6022.735225602497;6051.969740151271;6059.636421814529;6061.030235162353;5905.763769449174;5950.761969521343;5979.970100149645;5982.341942386247;5992;5970.552073649783;6177.2587289525545;6210.012795905267;6233.376662333912;6237.563370564017;4203.222403855297;4235.322348424237;4266.466691663542;4297.11909058636;4298.9570104298555;5681.687507187145;5933.673647949404;6119.3268740437625;6123;6134.270249739002;5917.467427931507;5943.7028148591535;5957.582969192115;5964.433378829004;5976.61152025117;5627.493525582717;5744.788256521186;5864.299353187528;5899.734511946886;5916.940830591639;5712.685802280915;5714.3714191438075;5739.306904463277;5845.269341332333;5850.268716410449;5985.730642121202;5989.850253743692;5990.7903223386975;6011.759529618941;6014.759409623566;5692.260006199168;5769.509591684754;5788.536917046542;5797.797077102281;5799.5070419014855 19:19:59 INFO - PROCESS | 6964 | |5;yui.html;707.2679776431395;721.2174790352467;735.3235023778124;835.5863847395539;844.4004756622797;15481.07113573185;16030.679386412265;16178.83821161788;16315.592110197236;16318.10250436227;14558.927205363958;15213.84786152138;15312.923435382836;15372.615684607863;15384.538463846102;817.8568750468644;821.0967935271184;821.5440430561036;821.8109834738013;822.6257053040852;829.601791140253;830.7341650671788;833.8540755367817;834.5201509132273;835.482001159282;886.0342226972631;887.4896934262792;887.8978917424482;888.0143041224236;890.3233542507709;865.948043117415;868.2836659755664;870.5473153959937;872.733816186063;876.6186708781669;636.099918615159;639.0541997843171;641.2945759664378;642.3287664390723;642.4635429416443;15033.173175475344;15074;15120.773188402183;15127.621809454742;15129.394824207018;15657.921710391489;15737.134457604827;15745.92127039369;15948.76076858848;15985.360585576564;12437.564685235973;12638.2417054977;12750.80873786894;12974.091813573054;13053.151545149534;3925.3130702127014;3936.8425262989444;3967.8809635710977;3969.940450893239;4067.5729048449784;79340.60329698314;79414;79488.60255698685;79823.6008819958;81244.59377703191;12209.145359824726;12255.222992666013;12263.957563607193;12398.5660501882;12524.561640342727;23368.298951031495;23379.883100584728;23423.7657623425;23480.178193763135;23593.29220123399;9071.546422678972;9125.315601329927;9202.539873006323;9254.629814807333;9302.813943721088;4906.779194936236;4940.505949405031;4981.352424184833;4990.17662085759;5168.53483186515;3684.09739613791;3736.3648179809497;3806.2958352704836;3819.656230939229;3825.5600605930117;641.3009819296989;642.1331202876173;655.4265018109154;673.6295037729229;678.5352033856725;642.9903551446732;756.7313603670727;776.8485145396706;780.4575819805294;781.6638845296463;9638.4216946982;9797;9805.509724513746;9809;10043.146332561668;763.1681467200777;770.8612449759097;771.9150893401721;778.1440415542858;783.5768684910199;4449.265871131227;4648.976755116203;4717.669763116617;4719.575238228507;4724.480307166209;89829.55085224532;122771;124599;129545.35227323804;132688;67514.32485675179;74803;77800.61099694579;90184;107323.46338268259;93388.53305733428;96269.51865240629;97606.51196743971;98196;99010;9036.59335329925;9163.86254206174;9244.606648019806;9333.719988400358;9374.390664606779;52659;53800.46199537955;55177;55180.44819551753;56574.43425565692;71713;81414.59292703499;81789;82862;84887;12541.561045363369;12611.180273282574;12654.746905062031;12811.423485942969;13154.40805163789;13227.933860330637;13235.470581176645;13293.135946163855;13475.730485390433;13503.797443038558;11609.30344179352;11672.766544669228;11857.288562686266;12129.211601246243;12170.208936419458;12848.743025139258;12949.935250323688;12966.35168241603;13514.459421623025;13598.456061757419;11780.921075463988;11861.169718119649;11968.413096232867;12085.697857553632;12208.877911221129;11018.889811101786;11039.172062095215;11123.769143898488;11273.605423810128;12026.75946481048;9882.357646752938;10149.23880708935;10535.525901334306;10591.788164236517;10739.516721747385 19:19:59 INFO - PROCESS | 6964 | __end_tp_report 19:19:59 INFO - PROCESS | 6964 | __start_cc_report 19:19:59 INFO - PROCESS | 6964 | _x_x_mozilla_cycle_collect,358 19:19:59 INFO - PROCESS | 6964 | __end_cc_report 19:19:59 INFO - PROCESS | 6964 | __startTimestamp1464833999148__endTimestamp 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | ------- Summary: start ------- 19:19:59 INFO - PROCESS | 6964 | Number of tests: 6 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#0] dojo.html Cycles:165 Average:5453.77 Median:5698.43 stddev:754.47 (13.2%) stddev-sans-first:733.89 19:19:59 INFO - PROCESS | 6964 | Values: 3102.6 3140.3 3163.9 3176.2 3184.9 5420.5 5459.7 5490.3 5525.5 5540.8 5397.6 5403.8 5499.4 5566.6 5580.9 5029.8 5062.3 5166.3 5203.5 5216.6 709.1 4907.8 5059.8 5075.6 5111.0 5086.5 5093.1 5105.4 5134.8 5152.3 5138.8 5170.1 5173.2 5175.3 5202.0 4937.3 4986.3 5002.9 5034.4 5048.4 5436.6 5464.0 5469.8 5470.6 5512.0 5703.3 5861.1 5904.4 5907.7 5978.9 5941.5 5969.0 5989.8 6052.8 6056.2 5555.9 5614.8 5615.7 5625.6 5639.5 5865.1 5895.6 5901.4 5915.7 5915.9 5838.6 5881.7 5886.1 5902.1 5903.4 5981.8 5995.8 6002.8 6006.0 6023.4 5655.7 5792.1 5885.1 5954.9 5986.4 5809.1 5842.0 5871.2 5895.8 5943.0 4245.8 4260.2 4268.5 4272.7 4278.1 3727.2 3810.0 3825.3 3827.3 3848.1 5579.7 5595.3 5616.1 5627.2 5689.8 5979.6 6003.8 6007.4 6031.6 6033.1 5500.9 5635.6 5644.2 5684.7 5701.6 4921.9 4945.0 4951.8 4965.8 5017.6 6133.1 6171.3 6183.1 6193.3 6211.5 5828.6 5898.2 5925.5 5948.4 6038.9 6163.2 6167.7 6173.1 6184.0 6185.3 5817.4 5862.9 5865.9 5871.9 5880.3 5746.0 5755.2 5798.4 5814.5 5870.5 5647.2 5726.8 5731.6 5743.8 5749.7 5601.7 5684.8 5703.0 5711.0 5724.1 5625.0 5627.1 5651.3 5684.8 5698.4 5776.6 5787.9 5818.4 5821.5 5843.2 5440.3 5700.2 5714.7 5715.3 5803.9 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#1] ext.html Cycles:180 Average:66687.79 Median:43364.28 stddev:134692.86 (310.6%) stddev-sans-first:134979.27 19:19:59 INFO - PROCESS | 6964 | Values: 586.3 616.5 638.9 647.1 661.3 39454.6 43786.6 44052.3 44128.0 44145.8 43367.6 43652.3 43960.8 43992.3 44033.9 8700.6 8876.6 8881.8 8895.0 8919.1 8803.9 8831.5 8884.5 8889.6 8890.1 8888.6 8938.7 8942.6 8945.5 8946.4 8843.1 8857.1 8870.5 8889.8 8914.5 8810.3 8909.5 8911.8 8913.5 8919.6 41497.6 41666.0 41712.0 41806.6 42185.2 3289.4 3474.5 3495.2 3535.3 3559.3 32870.3 33335.8 34016.5 34028.0 34104.3 4250.3 4272.4 4284.6 4428.9 4450.2 370686.0 373279.0 375224.0 378264.0 379186.0 64615.7 64760.7 65022.7 65072.3 65282.3 65591.7 67266.7 67491.3 67930.7 67961.7 16545.7 16754.3 16828.8 16920.5 16932.1 12529.5 12596.2 12640.1 12660.5 12717.1 20095.9 20367.2 20390.0 20511.0 20525.7 6489.0 7134.4 7168.4 7234.9 7491.4 982.2 1002.3 1043.5 1101.2 1132.0 33003.3 33077.8 33241.8 33296.3 33759.7 1103.2 1106.8 1162.3 1167.2 1186.2 17064.5 17428.7 17602.0 18120.1 18142.3 602958.0 606568.0 607931.0 608690.0 608700.0 61570.0 63128.7 63277.7 63327.0 63951.0 1373.9 1382.3 1402.7 1407.6 1410.9 32389.7 32419.2 33509.0 34541.5 35362.0 59690.7 60036.7 60559.4 60582.0 60639.4 507390.6 510345.0 510569.0 512789.0 512847.0 44917.6 45037.8 45047.7 46434.8 46728.5 50818.5 51108.7 51725.0 52245.7 52772.2 42630.0 43211.6 43361.0 44125.3 44529.6 41735.6 41974.4 42237.2 42400.8 42460.4 41534.8 41867.4 42794.4 42902.1 42944.6 36813.6 37640.0 38108.8 38461.6 38699.4 28079.6 28114.6 28367.3 28571.6 28699.7 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#2] jquery.html Cycles:180 Average:31242.04 Median:2922.10 stddev:83067.04 (2842.7%) stddev-sans-first:83267.77 19:19:59 INFO - PROCESS | 6964 | Values: 392.9 396.4 398.5 406.2 413.1 13799.8 18395.6 19093.3 19934.6 19950.6 17051.6 17125.7 17415.8 18473.3 18624.3 5702.6 5840.8 5853.1 7014.5 7439.5 7218.0 7311.7 7429.7 7529.2 7542.4 7413.7 7446.1 7464.1 7476.4 7482.8 7299.6 7360.7 7423.7 7484.0 7499.7 6953.5 7144.0 7163.5 7198.9 7224.4 24422.6 24458.3 25163.6 26143.6 26249.5 2479.0 2576.1 2813.7 3030.5 3209.6 15764.4 16048.1 16070.9 16246.4 16270.3 2063.8 2193.8 2203.1 2219.4 2228.5 71387.6 75277.5 95741.0 101641.0 102598.0 16310.8 17797.7 17849.1 18145.5 18239.3 32104.5 32152.4 32260.4 32537.5 32609.8 9620.0 9823.5 9860.3 9872.3 9919.5 8144.9 8167.3 8193.6 8333.7 8362.2 8670.4 8960.9 8977.0 9056.2 9170.2 3394.8 3416.2 3505.9 3527.7 3551.9 940.9 1072.4 1082.4 1092.6 1112.4 19114.0 19144.0 19194.2 19334.8 19671.1 957.6 1017.4 1028.6 1041.0 1068.4 10434.2 10775.3 10863.2 10912.5 10967.6 492885.0 499876.0 504699.0 505164.0 510487.0 100337.0 101927.5 102277.5 104448.5 105127.5 957.3 1003.4 1005.9 1030.1 1031.6 16034.9 16678.7 17089.7 17195.3 17548.9 42261.6 43283.8 43494.0 43939.8 44358.8 55737.4 58413.0 64129.0 64788.1 65388.0 8036.4 8039.3 8157.6 8256.4 8330.3 12553.2 12670.4 12919.4 13296.0 13411.1 11204.1 11414.5 11504.3 11713.5 11834.8 11248.0 11258.8 11296.8 11689.2 11844.7 11475.4 11915.6 11941.6 12108.3 12216.1 8216.8 8330.8 8474.5 8486.6 8502.7 8481.1 10844.6 11953.9 12290.9 12403.4 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#3] mootools.html Cycles:180 Average:5934.11 Median:4650.00 stddev:3424.99 (73.7%) stddev-sans-first:3418.00 19:19:59 INFO - PROCESS | 6964 | Values: 1447.5 1478.2 1598.7 1770.3 1818.0 7865.0 8640.2 8731.6 9278.3 9287.0 8760.7 9006.2 9041.7 9066.5 9091.9 2350.0 2377.6 2390.1 2398.3 2400.2 2276.1 2302.4 2303.8 2306.9 2322.9 2204.2 2209.4 2218.6 2241.2 2249.1 2311.1 2311.6 2319.2 2325.0 2342.8 2301.2 2322.5 2325.2 2325.5 2344.9 8991.9 9039.0 9078.0 9083.7 9132.8 5135.2 5237.9 5263.4 5263.8 5267.6 3284.4 3389.5 3400.3 3530.7 3545.3 1090.3 1108.2 1119.8 1120.2 1141.8 12359.7 12376.3 12407.9 12408.9 12425.6 4513.2 4563.7 4633.8 4666.2 4690.4 10272.5 10278.3 10279.3 10342.0 10386.5 5089.0 5212.7 5212.9 5215.4 5218.6 4228.3 4696.1 4752.0 4831.0 4839.0 4062.2 4071.1 4072.7 4154.2 4185.7 1246.7 1246.8 1247.3 1264.5 1294.1 803.3 888.1 918.7 934.5 965.7 5631.7 6103.1 6238.4 6356.2 6496.7 928.7 980.3 991.5 1002.8 1026.5 3885.8 3893.4 3945.1 4004.9 4258.6 11168.4 11619.3 11621.8 11642.6 11649.1 11399.3 11457.8 11466.9 11470.9 11474.3 8413.6 8471.7 8511.5 8523.5 8525.4 5964.9 6104.4 6202.6 6373.6 6377.3 10374.0 10397.1 10526.9 10575.5 10619.8 10105.5 10549.8 10806.1 10829.4 10836.2 7790.9 8221.8 8420.4 8482.4 8601.1 8695.4 8795.6 8917.8 8943.5 8944.1 7492.1 7673.9 7678.8 7904.4 7947.4 7484.7 7767.7 7805.8 8016.6 8119.4 6816.6 6970.0 7007.8 7031.2 7032.2 5005.3 5221.0 5407.9 5435.2 5471.4 5248.2 5393.1 5412.8 5473.4 5566.9 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#4] prototype.html Cycles:180 Average:4941.28 Median:5686.97 stddev:1456.39 (25.6%) stddev-sans-first:1418.86 19:19:59 INFO - PROCESS | 6964 | Values: 335.7 338.5 342.9 344.6 345.1 5489.5 5634.8 5663.5 5702.2 5710.9 5459.6 5571.9 5580.4 5620.0 5630.3 4125.9 4253.3 4337.9 4348.3 4379.7 4360.9 4364.1 4370.9 4398.9 4411.9 4354.3 4369.0 4369.8 4385.7 4402.8 4288.6 4302.2 4306.2 4319.9 4325.9 3816.5 3825.7 3842.1 3856.8 3861.5 5388.8 5423.2 5431.9 5434.2 5444.8 4828.6 4974.2 4988.8 4995.8 5036.2 5809.9 5810.4 5831.6 5837.8 5849.4 4204.7 4219.9 4225.4 4227.5 4249.5 5809.5 6063.7 6108.3 6120.3 6133.3 4219.7 4227.7 4240.3 4253.8 4261.8 4304.5 4315.6 4326.2 4337.7 4342.1 4715.9 4918.2 4925.3 4928.6 5002.1 5833.4 5843.0 5845.4 5888.2 5917.4 1478.2 1486.4 1498.9 1501.4 1504.3 959.8 971.0 1006.7 1011.3 1025.5 5711.7 5756.8 5761.9 5762.0 5779.5 5834.8 6025.4 6077.4 6083.8 6084.8 5530.5 5659.4 5679.5 5722.6 5751.8 3203.0 3241.0 3245.7 3261.3 3272.2 5981.4 6208.2 6218.0 6220.3 6283.9 6086.6 6091.5 6106.0 6108.1 6133.4 5993.8 6142.8 6154.4 6175.3 6208.7 5944.0 6022.7 6052.0 6059.6 6061.0 5905.8 5950.8 5980.0 5982.3 5992.0 5970.6 6177.3 6210.0 6233.4 6237.6 4203.2 4235.3 4266.5 4297.1 4299.0 5681.7 5933.7 6119.3 6123.0 6134.3 5917.5 5943.7 5957.6 5964.4 5976.6 5627.5 5744.8 5864.3 5899.7 5916.9 5712.7 5714.4 5739.3 5845.3 5850.3 5985.7 5989.9 5990.8 6011.8 6014.8 5692.3 5769.5 5788.5 5797.8 5799.5 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - PROCESS | 6964 | [#5] yui.html Cycles:180 Average:21209.35 Median:4923.64 stddev:30850.26 (626.6%) stddev-sans-first:30898.40 19:19:59 INFO - PROCESS | 6964 | Values: 707.3 721.2 735.3 835.6 844.4 15481.1 16030.7 16178.8 16315.6 16318.1 14558.9 15213.8 15312.9 15372.6 15384.5 817.9 821.1 821.5 821.8 822.6 829.6 830.7 833.9 834.5 835.5 886.0 887.5 887.9 888.0 890.3 865.9 868.3 870.5 872.7 876.6 636.1 639.1 641.3 642.3 642.5 15033.2 15074.0 15120.8 15127.6 15129.4 15657.9 15737.1 15745.9 15948.8 15985.4 12437.6 12638.2 12750.8 12974.1 13053.2 3925.3 3936.8 3967.9 3969.9 4067.6 79340.6 79414.0 79488.6 79823.6 81244.6 12209.1 12255.2 12264.0 12398.6 12524.6 23368.3 23379.9 23423.8 23480.2 23593.3 9071.5 9125.3 9202.5 9254.6 9302.8 4906.8 4940.5 4981.4 4990.2 5168.5 3684.1 3736.4 3806.3 3819.7 3825.6 641.3 642.1 655.4 673.6 678.5 643.0 756.7 776.8 780.5 781.7 9638.4 9797.0 9805.5 9809.0 10043.1 763.2 770.9 771.9 778.1 783.6 4449.3 4649.0 4717.7 4719.6 4724.5 89829.6 122771.0 124599.0 129545.4 132688.0 67514.3 74803.0 77800.6 90184.0 107323.5 93388.5 96269.5 97606.5 98196.0 99010.0 9036.6 9163.9 9244.6 9333.7 9374.4 52659.0 53800.5 55177.0 55180.4 56574.4 71713.0 81414.6 81789.0 82862.0 84887.0 12541.6 12611.2 12654.7 12811.4 13154.4 13227.9 13235.5 13293.1 13475.7 13503.8 11609.3 11672.8 11857.3 12129.2 12170.2 12848.7 12949.9 12966.4 13514.5 13598.5 11780.9 11861.2 11968.4 12085.7 12208.9 11018.9 11039.2 11123.8 11273.6 12026.8 9882.4 10149.2 10535.5 10591.8 10739.5 19:19:59 INFO - PROCESS | 6964 | -------- Summary: end -------- 19:19:59 INFO - PROCESS | 6964 | 19:19:59 INFO - TEST-INFO | 6964: exit 0 19:19:59 INFO - TEST-OK | dromaeo_css | took 1110303ms 19:19:59 INFO - TEST-START | kraken 19:19:59 INFO - operating with platform_type : linux_ 19:19:59 INFO - Initialising browser for kraken test... 19:19:59 INFO - TEST-INFO | started process 7203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2gDqNb/profile http://localhost:44900/getInfo.html) 19:20:04 INFO - PROCESS | 7203 | __metrics Screen width/height:1600/1200 19:20:04 INFO - PROCESS | 7203 | colorDepth:24 19:20:04 INFO - PROCESS | 7203 | Browser inner width/height: 1024/697 19:20:04 INFO - PROCESS | 7203 | __metrics 19:20:05 ERROR - PROCESS | 7203 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:20:06 INFO - TEST-INFO | 7203: exit 0 19:20:06 INFO - Browser initialized. 19:20:06 INFO - Running cycle 1/1 for kraken test... 19:20:06 INFO - TEST-INFO | started process 7325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2gDqNb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:17 INFO - PROCESS | 7325 | RSS: Main: 167251968 19:20:17 INFO - PROCESS | 7325 | 19:20:20 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44900/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:21 INFO - PROCESS | 7325 | RSS: Main: 172670976 19:20:21 INFO - PROCESS | 7325 | 19:20:24 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44900/tests/kraken/driver.html?testName=audio-dft) 19:20:24 INFO - PROCESS | 7325 | RSS: Main: 171921408 19:20:24 INFO - PROCESS | 7325 | 19:20:27 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44900/tests/kraken/driver.html?testName=audio-fft) 19:20:28 INFO - PROCESS | 7325 | RSS: Main: 166936576 19:20:28 INFO - PROCESS | 7325 | 19:20:30 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44900/tests/kraken/driver.html?testName=audio-oscillator) 19:20:31 INFO - PROCESS | 7325 | RSS: Main: 167903232 19:20:31 INFO - PROCESS | 7325 | 19:20:33 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:33 INFO - PROCESS | 7325 | RSS: Main: 168390656 19:20:33 INFO - PROCESS | 7325 | 19:20:37 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44900/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:37 INFO - PROCESS | 7325 | RSS: Main: 168669184 19:20:37 INFO - PROCESS | 7325 | 19:20:41 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44900/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:41 INFO - PROCESS | 7325 | RSS: Main: 166023168 19:20:41 INFO - PROCESS | 7325 | 19:20:44 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44900/tests/kraken/driver.html?testName=json-parse-financial) 19:20:45 INFO - PROCESS | 7325 | RSS: Main: 167407616 19:20:45 INFO - PROCESS | 7325 | 19:20:46 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:47 INFO - PROCESS | 7325 | RSS: Main: 167821312 19:20:47 INFO - PROCESS | 7325 | 19:20:49 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:49 INFO - PROCESS | 7325 | RSS: Main: 168259584 19:20:49 INFO - PROCESS | 7325 | 19:20:51 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:52 INFO - PROCESS | 7325 | RSS: Main: 168419328 19:20:52 INFO - PROCESS | 7325 | 19:20:55 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:55 INFO - PROCESS | 7325 | RSS: Main: 168566784 19:20:55 INFO - PROCESS | 7325 | 19:20:58 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:59 INFO - PROCESS | 7325 | RSS: Main: 168525824 19:20:59 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | Cycle 1(1): loaded http://localhost:44900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44900/tests/kraken/driver.html?testName=ai-astar) 19:21:00 INFO - PROCESS | 7325 | RSS: Main: 168939520 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | __start_tp_report 19:21:00 INFO - PROCESS | 7325 | _x_x_mozilla_page_load 19:21:00 INFO - PROCESS | 7325 | _x_x_mozilla_page_load_details 19:21:00 INFO - PROCESS | 7325 | |i|pagename|runs| 19:21:00 INFO - PROCESS | 7325 | |0;ai-astar;113;108;112;113;112;116;112;112;112;114 19:21:00 INFO - PROCESS | 7325 | |1;audio-beat-detection;158;125;157;184;140;151;165;141;181;127 19:21:00 INFO - PROCESS | 7325 | |2;audio-dft;163;162;162;161;163;171;169;163;163;162 19:21:00 INFO - PROCESS | 7325 | |3;audio-fft;75;76;77;159;75;75;75;76;169;75 19:21:00 INFO - PROCESS | 7325 | |4;audio-oscillator;83;84;144;83;83;85;153;84;84;139 19:21:00 INFO - PROCESS | 7325 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;118;118;118 19:21:00 INFO - PROCESS | 7325 | |6;imaging-darkroom;148;147;147;148;147;147;148;148;148;147 19:21:00 INFO - PROCESS | 7325 | |7;imaging-desaturate;96;95;95;98;95;95;96;96;96;96 19:21:00 INFO - PROCESS | 7325 | |8;json-parse-financial;53;53;54;54;55;54;57;54;54;64 19:21:00 INFO - PROCESS | 7325 | |9;json-stringify-tinderbox;63;63;64;62;63;64;62;64;62;63 19:21:00 INFO - PROCESS | 7325 | |10;stanford-crypto-aes;84;82;80;80;88;80;82;78;104;80 19:21:00 INFO - PROCESS | 7325 | |11;stanford-crypto-ccm;136;125;122;124;122;138;121;127;129;130 19:21:00 INFO - PROCESS | 7325 | |12;stanford-crypto-pbkdf2;163;160;163;159;159;161;161;159;157;163 19:21:00 INFO - PROCESS | 7325 | |13;stanford-crypto-sha256-iterative;63;67;66;63;66;64;64;62;65;62 19:21:00 INFO - PROCESS | 7325 | __end_tp_report 19:21:00 INFO - PROCESS | 7325 | __start_cc_report 19:21:00 INFO - PROCESS | 7325 | _x_x_mozilla_cycle_collect,862 19:21:00 INFO - PROCESS | 7325 | __end_cc_report 19:21:00 INFO - PROCESS | 7325 | __startTimestamp1464834060963__endTimestamp 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | ------- Summary: start ------- 19:21:00 INFO - PROCESS | 7325 | Number of tests: 14 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:2.01 (1.8%) stddev-sans-first:2.12 19:21:00 INFO - PROCESS | 7325 | Values: 113.0 108.0 112.0 113.0 112.0 116.0 112.0 112.0 112.0 114.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:157.50 stddev:20.29 (12.9%) stddev-sans-first:21.44 19:21:00 INFO - PROCESS | 7325 | Values: 158.0 125.0 157.0 184.0 140.0 151.0 165.0 141.0 181.0 127.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.31 (2.0%) stddev-sans-first:3.50 19:21:00 INFO - PROCESS | 7325 | Values: 163.0 162.0 162.0 161.0 163.0 171.0 169.0 163.0 163.0 162.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.40 (49.9%) stddev-sans-first:39.08 19:21:00 INFO - PROCESS | 7325 | Values: 75.0 76.0 77.0 159.0 75.0 75.0 75.0 76.0 169.0 75.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:83.50 stddev:29.96 (35.9%) stddev-sans-first:30.96 19:21:00 INFO - PROCESS | 7325 | Values: 83.0 84.0 144.0 83.0 83.0 85.0 153.0 84.0 84.0 139.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:21:00 INFO - PROCESS | 7325 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:21:00 INFO - PROCESS | 7325 | Values: 148.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 148.0 147.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 19:21:00 INFO - PROCESS | 7325 | Values: 96.0 95.0 95.0 98.0 95.0 95.0 96.0 96.0 96.0 96.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:3.29 (6.1%) stddev-sans-first:3.40 19:21:00 INFO - PROCESS | 7325 | Values: 53.0 53.0 54.0 54.0 55.0 54.0 57.0 54.0 54.0 64.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:21:00 INFO - PROCESS | 7325 | Values: 63.0 63.0 64.0 62.0 63.0 64.0 62.0 64.0 62.0 63.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:7.63 (9.4%) stddev-sans-first:8.09 19:21:00 INFO - PROCESS | 7325 | Values: 84.0 82.0 80.0 80.0 88.0 80.0 82.0 78.0 104.0 80.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:5.89 (4.6%) stddev-sans-first:5.36 19:21:00 INFO - PROCESS | 7325 | Values: 136.0 125.0 122.0 124.0 122.0 138.0 121.0 127.0 129.0 130.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:2.07 (1.3%) stddev-sans-first:1.99 19:21:00 INFO - PROCESS | 7325 | Values: 163.0 160.0 163.0 159.0 159.0 161.0 161.0 159.0 157.0 163.0 19:21:00 INFO - PROCESS | 7325 | 19:21:00 INFO - PROCESS | 7325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.75 (2.7%) stddev-sans-first:1.80 19:21:00 INFO - PROCESS | 7325 | Values: 63.0 67.0 66.0 63.0 66.0 64.0 64.0 62.0 65.0 62.0 19:21:00 INFO - PROCESS | 7325 | -------- Summary: end -------- 19:21:00 INFO - PROCESS | 7325 | 19:21:01 INFO - TEST-INFO | 7325: exit 0 19:21:01 INFO - TEST-OK | kraken | took 62054ms 19:21:01 INFO - SUITE-END | took 1172s 19:21:02 INFO - Completed test suite (00:19:32) 19:21:02 INFO - javascript benchmark 19:21:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7619.0021621493315, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.612173478315, 3140.3405284890173, 3163.9050828475138, 3176.237702951291, 3184.920376990575, 5420.485053919876, 5459.727013649316, 5490.313710786152, 5525.530329921961, 5540.778368865241, 5397.568194544437, 5403.756830942607, 5499.3675727291375, 5566.582506312023, 5580.91628625571, 5029.773660185291, 5062.316587260728, 5166.250893620423, 5203.4536373680785, 5216.60667717723, 709.1396877072405, 4907.803687852482, 5059.848204553869, 5075.6447048706605, 5111.003354345904, 5086.491350864921, 5093.083245015896, 5105.438401775802, 5134.794608215667, 5152.304438900756, 5138.7656192346985, 5170.146925757245, 5173.224016397533, 5175.301334319894, 5201.9596080783995, 4937.259411088366, 4986.276989836453, 5002.874928126789, 5034.421041580192, 5048.3941926969, 5436.646617969819, 5463.972680136613, 5469.835904922858, 5470.617056806025, 5512.035393806108, 5703.287089113861, 5861.0915308127305, 5904.380040095771, 5907.704614769287, 5978.940210597925, 5941.465268125889, 5969.0, 5989.8203053908455, 6052.757889684407, 6056.242969628796, 5555.944440555583, 5614.803481878155, 5615.66306021636, 5625.634333768292, 5639.492445679867, 5865.061590145556, 5895.557833162444, 5901.380355062743, 5915.704214789243, 5915.881682366415, 5838.562107841929, 5881.676507792113, 5886.117082437669, 5902.144189092557, 5903.409659034148, 5981.790637327673, 5995.790147344822, 6002.759889604367, 6006.039033754666, 6023.427774361428, 5655.717214139277, 5792.073268277056, 5885.146653735184, 5954.910676339859, 5986.3714309997695, 5809.099589563624, 5841.970790146022, 5871.178035075093, 5895.764169433261, 5943.049112142036, 4245.80893859777, 4260.169266992907, 4268.487781466244, 4272.6795490338345, 4278.144371125787, 3727.1613886875234, 3809.961900381016, 3825.3305671507374, 3827.3302172120325, 3848.0764616491842, 5579.7489112990015, 5595.328560572757, 5616.073347897633, 5627.212190293362, 5689.800856969986, 5979.611325263931, 6003.7898673546215, 6007.3992600739575, 6031.577789554689, 6033.095035744585, 5500.862478437991, 5635.605507614428, 5644.209810626516, 5684.744186511617, 5701.600887937804, 4921.901561968741, 4944.950550494521, 4951.801927922915, 4965.776540055706, 5017.57350625201, 6133.1413602095745, 6171.259448866075, 6183.072539119168, 6193.349698281706, 6211.503079753609, 5828.591998560145, 5898.233229680114, 5925.466707996128, 5948.37542058095, 6038.909416358758, 6163.19878415803, 6167.722452489559, 6173.135760993375, 6184.0, 6185.257769067741, 5817.447342502455, 5862.912056319074, 5865.94134058654, 5871.853203669772, 5880.294364676266, 5746.0, 5755.1942728017275, 5798.449147330997, 5814.505767009682, 5870.5010074142465, 5647.209390685225, 5726.79956201531, 5731.627444216113, 5743.798967036134, 5749.741261643152, 5601.747921343468, 5684.772609095755, 5703.0, 5711.0, 5724.141378793214, 5625.0, 5627.071533196977, 5651.321841379061, 5684.8294551163535, 5698.430156984268, 5776.624519406225, 5787.884242315215, 5818.359980402237, 5821.534277257894, 5843.240378750906, 5440.265564148789, 5700.173474846041, 5714.742836572447, 5715.342735585295, 5803.8549036274435], "value": 5401.602504740656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3374386942756, 616.5468380740157, 638.897901120567, 647.1069923505562, 661.2659947458318, 39454.60545394545, 43786.56213437865, 44052.33921491172, 44128.0, 44145.7792711036, 43367.566324336745, 43652.345214821806, 43960.780196098975, 43992.34011489822, 44033.899152521124, 8700.608472618747, 8876.644934202624, 8881.777955551099, 8894.955525222365, 8919.063498332678, 8803.911960880405, 8831.514266715329, 8884.511351875644, 8889.599968001423, 8890.066543012988, 8888.644454221823, 8938.687145949893, 8942.597583108776, 8945.463272203657, 8946.3737538372, 8843.071477494866, 8857.114288571156, 8870.467771933672, 8889.822203555925, 8914.465132092095, 8810.295176385938, 8909.465432074032, 8911.777205569848, 8913.509756963364, 8919.554022298858, 41497.585024149674, 41666.0, 41712.0, 41806.581934180576, 42185.1562968742, 3289.3723766237085, 3474.461458473915, 3495.1961048958883, 3535.3106144301873, 3559.270349578356, 32870.34259314824, 33335.83332083324, 34016.48975265373, 34028.0, 34104.317913641586, 4250.298700714409, 4272.359146128075, 4284.571542845691, 4428.911421771579, 4450.198964186445, 370686.0, 373279.0, 375224.0, 378264.0, 379186.0, 64615.67692161603, 64760.67619661872, 65022.67488662527, 65072.349276506626, 65282.347176527626, 65591.67204163948, 67266.66366668136, 67491.3250867485, 67930.66034669794, 67961.66019169873, 16545.6690866182, 16754.329826807036, 16828.83171168297, 16920.492385228463, 16932.06873621938, 12529.498820047278, 12596.244225346509, 12640.05199610033, 12660.49358025687, 12717.10980231375, 20095.899520502597, 20367.185312587626, 20390.0, 20511.0, 20525.692114618294, 6489.0, 7134.429245660334, 7168.354848063699, 7234.855302893912, 7491.438142139361, 982.2485798364257, 1002.318423472046, 1043.4730461117088, 1101.1796211822243, 1132.0038366237823, 33003.326706560336, 33077.834610827274, 33241.83379083138, 33296.3340733184, 33759.66240337614, 1103.2167161315556, 1106.8229083346787, 1162.2677713040898, 1167.2062997161843, 1186.1874615888144, 17064.48806535806, 17428.651426971388, 17602.0, 18120.095053617282, 18142.274309027754, 602958.0, 606568.0, 607931.0, 608690.0, 608700.0, 61570.0, 63128.68435657792, 63277.68361158165, 63327.0, 63951.0, 1373.9106958047696, 1382.3088455772113, 1402.705431859321, 1407.6480879780056, 1410.9223992680295, 32389.67610323961, 32419.18952026218, 33509.0, 34541.48187777135, 35362.0, 59690.70154649199, 60036.69981650238, 60559.39440605538, 60582.0, 60639.39360606337, 507390.5565666072, 510345.0, 510569.0, 512789.0, 512847.0, 44917.550824491336, 45037.77481112705, 45047.73864338515, 46434.767826160656, 46728.532714673776, 50818.491815081376, 51108.74445627748, 51725.0, 52245.7387713059, 52772.20841687454, 42629.95015473525, 43211.56788432076, 43361.0, 44125.33811992758, 44529.55470445254, 41735.58264417317, 41974.370384443646, 42237.155256894075, 42400.78799605982, 42460.363094554225, 41534.79232603818, 41867.371989419575, 42794.35808462813, 42902.14195716131, 42944.570554294056, 36813.63186368102, 37640.0, 38108.80945595254, 38461.615383845805, 38699.41950870683, 28079.578806317513, 28114.578281326205, 28367.29081772972, 28571.571426429036, 28699.71300287054], "value": 21186.07881265883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.8566073383216, 396.3539430727913, 398.4600865826804, 406.21194881929057, 413.14272883766193, 13799.793003104962, 18395.632087358263, 19093.331733389336, 19934.60130797385, 19950.600987980233, 17051.57371065721, 17125.657486850254, 17415.82584174158, 18473.261069557237, 18624.348147814828, 5702.600817942745, 5840.8247752567495, 5853.09277062056, 7014.508984371096, 7439.4792364534505, 7218.025566548527, 7311.707531698752, 7429.665665045059, 7529.209433009537, 7542.434317426188, 7413.740519081834, 7446.069241344832, 7464.066991626047, 7476.401887848959, 7482.775516734507, 7299.63501824912, 7360.742374016911, 7423.665935032936, 7484.0, 7499.725046742067, 6953.478489113337, 7144.0, 7163.534370265916, 7198.856022879566, 7224.422046236341, 24422.633660495107, 24458.26625201229, 25163.62254566183, 26143.60784588233, 26249.475010499875, 2478.950420991588, 2576.0726138590094, 2813.6904940456534, 3030.499967505359, 3209.630892447375, 15764.448244311508, 16048.117353545551, 16070.919645401815, 16246.350145994145, 16270.349186032545, 2063.787079027573, 2193.8025577698086, 2203.10774136475, 2219.3896678413403, 2228.4985878177445, 71387.64306178436, 75277.49445011123, 95741.0, 101641.0, 102598.0, 16310.75533866993, 17797.7330340045, 17849.107544622977, 18145.546361341072, 18239.270429182685, 32104.518432223536, 32152.356952860813, 32260.35479290401, 32537.51193732096, 32609.836950815094, 9619.951900240454, 9823.508824558743, 9860.260480463994, 9872.308938374244, 9919.50402479873, 8144.918550814535, 8167.346612271004, 8193.631286592117, 8333.749987500385, 8362.163783621589, 8670.393072484992, 8960.8655870162, 8976.955115224513, 9056.184943354998, 9170.174684278314, 3394.8302584870657, 3416.1630400551526, 3505.8948231553095, 3527.7177825773874, 3551.94672079919, 940.8776859008285, 1072.4316112460408, 1082.410086502858, 1092.6285063078592, 1112.3826276416667, 19114.0, 19144.0, 19194.232230710895, 19334.80665193358, 19671.114799834042, 957.636098282662, 1017.3641474078701, 1028.6296933104077, 1040.99479502602, 1068.4497483795851, 10434.16526677864, 10775.299605525615, 10863.239573229956, 10912.508937097691, 10967.561297548009, 492885.0, 499876.0, 504699.0, 505164.0, 510487.0, 100337.0, 101927.49036254772, 102277.48861255647, 104448.47775761073, 105127.47436262769, 957.3155194036158, 1003.3879333606494, 1005.9396436213705, 1030.0832259289239, 1031.6440827914357, 16034.919825400799, 16678.66642667164, 17089.658206836044, 17195.312187512358, 17548.91225543864, 42261.57738422576, 43283.783581081894, 43494.0, 43939.78030109957, 44358.778206108764, 55737.44262557485, 58413.0, 64129.0, 64788.056358309324, 65388.0, 8036.357091432788, 8039.316658083894, 8157.592120394075, 8256.380771442286, 8330.250277475056, 12553.184043037174, 12670.429830657828, 12919.354032298535, 13296.0, 13411.061225714106, 11204.103671706082, 11414.48634811419, 11504.309741415542, 11713.472893719974, 11834.82247766267, 11248.0, 11258.831117533407, 11296.830547541958, 11689.181757276909, 11844.70388240301, 11475.426228688699, 11915.582954596548, 11941.582044628396, 12108.334041627442, 12216.083793715328, 8216.794580135544, 8330.750077497685, 8474.533900635277, 8486.61810218554, 8502.74491765248, 8481.06708262103, 10844.60803820154, 11953.880461195276, 12290.938545307215, 12403.379831008593], "value": 10535.943401858618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.4861424194407, 1478.1869971515666, 1598.7282162032454, 1770.3007312111708, 1817.9727304090434, 7864.960675196616, 8640.179182977616, 8731.607077681503, 9278.304127190453, 9287.0, 8760.693375731835, 9006.189442950134, 9041.683541076047, 9066.501342426163, 9091.909080909189, 2350.0129945422923, 2377.619580867062, 2390.055927908475, 2398.2565404724505, 2400.1599440195964, 2276.112316196676, 2302.3898666853215, 2303.79265866072, 2306.9077236910503, 2322.907083716658, 2204.162418281051, 2209.359285807114, 2218.5673793610254, 2241.1707668162803, 2249.066637345508, 2311.05246848792, 2311.641695537194, 2319.1535089692225, 2324.988375058114, 2342.847714898535, 2301.1945818963395, 2322.465832858435, 2325.162941341116, 2325.5348930213854, 2344.871032093234, 8991.865122023175, 9039.0, 9077.954610226907, 9083.727488175366, 9132.817343653156, 5135.204043373245, 5237.921431178535, 5263.42102368743, 5263.789448422059, 5267.604929630293, 3284.3871741084854, 3389.5254664347012, 3400.336934297813, 3530.73519486037, 3545.2554963457706, 1090.3131027452732, 1108.2076315434422, 1119.7648493816228, 1120.1724553727418, 1141.7887690777234, 12359.69100772488, 12376.257424554555, 12407.937960310232, 12408.875911240862, 12425.565105221274, 4513.232750432434, 4563.680542362069, 4633.791479383436, 4666.206744853315, 4690.390249267573, 10272.486375681186, 10278.280520363503, 10279.331843430302, 10342.0, 10386.480675966171, 5089.0, 5212.7228828936395, 5212.947870521246, 5215.374155101336, 5218.556422704037, 4228.281192197333, 4696.060787842445, 4751.952480475151, 4831.033793241366, 4838.975805120952, 4062.2000009745652, 4071.145059537471, 4072.6538244249573, 4154.189932963103, 4185.748855068706, 1246.7007918099591, 1246.7755803955195, 1247.289045244202, 1264.525802823941, 1294.1458637299525, 803.2609998801117, 888.1118881118881, 918.6646873890982, 934.514052692596, 965.7006328038331, 5631.690257035821, 6103.1455596216565, 6238.438540531283, 6356.198867212039, 6496.675166241669, 928.7213835849218, 980.3088822380205, 991.5339790298548, 1002.7844013536978, 1026.5021464589668, 3885.7668539887695, 3893.435451859521, 3945.072907866649, 4004.8598299059395, 4258.593641400404, 11168.441577921072, 11619.302841829349, 11621.76756464866, 11642.592509262135, 11649.1263155262, 11399.316041037564, 11457.828132578017, 11466.885331146748, 11470.942645286721, 11474.311541307548, 8413.621387037598, 8471.66113355459, 8511.531865747444, 8523.531205783742, 8525.44584601999, 5964.8807023860145, 6104.38956104386, 6202.596831205957, 6373.6494492801485, 6377.330380310186, 10374.0, 10397.11624511925, 10526.894731052898, 10575.524101415609, 10619.840702389625, 10105.494725263561, 10549.78900421972, 10806.081483074027, 10829.404382758708, 10836.241463097507, 7790.9220907790195, 8221.835563288581, 8420.410571259952, 8482.406231563979, 8601.13988601135, 8695.434796738191, 8795.560221989002, 8917.777055573662, 8943.508107053915, 8944.060873608438, 7492.138404083382, 7673.923260767321, 7678.846423071619, 7904.407169462198, 7947.403944704286, 7484.738034168778, 7767.72812951544, 7805.804854878674, 8016.559089249914, 8119.350451963947, 6816.591004539743, 6970.0, 7007.8248043797275, 7031.191412987572, 7032.1912980007955, 5005.324281221989, 5220.973895130652, 5407.864803379947, 5435.211894275387, 5471.425500322568, 5248.186531087687, 5393.083175860192, 5412.83761487156, 5473.425290344616, 5566.944330556643], "value": 4712.677304550321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.66768898790195, 338.45508730943175, 342.92969941162056, 344.5589645254076, 345.14576423352224, 5489.533389661879, 5634.77460901564, 5663.451446848914, 5702.173184888194, 5710.942890571104, 5459.617826752119, 5571.860703482415, 5580.358258800239, 5620.0, 5630.296212973379, 4125.865387018572, 4253.29820579604, 4337.934930976022, 4348.260795664744, 4379.715318504287, 4360.89097772555, 4364.127174565084, 4370.868873933771, 4398.934015989763, 4411.86764397067, 4354.281543545327, 4368.956310436887, 4369.825206991716, 4385.736855788663, 4402.801873915681, 4288.592583704559, 4302.182585308781, 4306.246406878784, 4319.898425901407, 4325.940144664546, 3816.484774555455, 3825.7321987460887, 3842.1163132479687, 3856.8071596420345, 3861.5366156061173, 5388.817528900801, 5423.159410291411, 5431.918521222185, 5434.152388188035, 5444.8366549003595, 4828.637852161102, 4974.228994505857, 4988.7505624718615, 4995.751062234442, 5036.244563315532, 5809.912851307234, 5810.418958104198, 5831.562632802556, 5837.795677151279, 5849.38581448946, 4204.66362690984, 4219.87340379786, 4225.366195070733, 4227.492700875914, 4249.490061192646, 5809.477147056785, 6063.666498342589, 6108.259146143372, 6120.296165940929, 6133.325334213233, 4219.662427005832, 4227.682923780729, 4240.342746874239, 4253.829846806093, 4261.765602891871, 4304.526502084768, 4315.626405476975, 4326.156399502067, 4337.652987760972, 4342.109867477159, 4715.929261061086, 4918.163912134945, 4925.310456536088, 4928.6303527235605, 5002.1496345621335, 5833.412451342394, 5843.03589907669, 5845.357010728816, 5888.205092312569, 5917.378675239124, 1478.1943840606896, 1486.435154641251, 1498.887583431247, 1501.4144483651385, 1504.2553935801848, 959.7696552827272, 970.9514524273758, 1006.7332156978407, 1011.292095533115, 1025.5333823110466, 5711.743861174896, 5756.769729210785, 5761.88476230473, 5761.962846687637, 5779.537636989031, 5834.795782147605, 6025.367336429612, 6077.392260773976, 6083.847903802441, 6084.84387966285, 5530.5022547970075, 5659.377468478464, 5679.460451257124, 5722.599418040781, 5751.827445176651, 3202.9679703203137, 3240.9837950810097, 3245.659205783406, 3261.2662151015834, 3272.181954511372, 5981.401859813984, 6208.161898143783, 6217.96891015542, 6220.25356957159, 6283.874322513524, 6086.60437071589, 6091.472039103723, 6105.9694701526205, 6108.144859719554, 6133.362654058708, 5993.760249590055, 6142.802153580009, 6154.353792851686, 6175.320714721377, 6208.72060757267, 5943.959807033838, 6022.735225602497, 6051.969740151271, 6059.636421814529, 6061.030235162353, 5905.763769449174, 5950.761969521343, 5979.970100149645, 5982.341942386247, 5992.0, 5970.552073649783, 6177.2587289525545, 6210.012795905267, 6233.376662333912, 6237.563370564017, 4203.222403855297, 4235.322348424237, 4266.466691663542, 4297.11909058636, 4298.9570104298555, 5681.687507187145, 5933.673647949404, 6119.3268740437625, 6123.0, 6134.270249739002, 5917.467427931507, 5943.7028148591535, 5957.582969192115, 5964.433378829004, 5976.61152025117, 5627.493525582717, 5744.788256521186, 5864.299353187528, 5899.734511946886, 5916.940830591639, 5712.685802280915, 5714.3714191438075, 5739.306904463277, 5845.269341332333, 5850.268716410449, 5985.730642121202, 5989.850253743692, 5990.7903223386975, 6011.759529618941, 6014.759409623566, 5692.260006199168, 5769.509591684754, 5788.536917046542, 5797.797077102281, 5799.5070419014855], "value": 4473.717174952327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2679776431395, 721.2174790352467, 735.3235023778124, 835.5863847395539, 844.4004756622797, 15481.07113573185, 16030.679386412265, 16178.83821161788, 16315.592110197236, 16318.10250436227, 14558.927205363958, 15213.84786152138, 15312.923435382836, 15372.615684607863, 15384.538463846102, 817.8568750468644, 821.0967935271184, 821.5440430561036, 821.8109834738013, 822.6257053040852, 829.601791140253, 830.7341650671788, 833.8540755367817, 834.5201509132273, 835.482001159282, 886.0342226972631, 887.4896934262792, 887.8978917424482, 888.0143041224236, 890.3233542507709, 865.948043117415, 868.2836659755664, 870.5473153959937, 872.733816186063, 876.6186708781669, 636.099918615159, 639.0541997843171, 641.2945759664378, 642.3287664390723, 642.4635429416443, 15033.173175475344, 15074.0, 15120.773188402183, 15127.621809454742, 15129.394824207018, 15657.921710391489, 15737.134457604827, 15745.92127039369, 15948.76076858848, 15985.360585576564, 12437.564685235973, 12638.2417054977, 12750.80873786894, 12974.091813573054, 13053.151545149534, 3925.3130702127014, 3936.8425262989444, 3967.8809635710977, 3969.940450893239, 4067.5729048449784, 79340.60329698314, 79414.0, 79488.60255698685, 79823.6008819958, 81244.59377703191, 12209.145359824726, 12255.222992666013, 12263.957563607193, 12398.5660501882, 12524.561640342727, 23368.298951031495, 23379.883100584728, 23423.7657623425, 23480.178193763135, 23593.29220123399, 9071.546422678972, 9125.315601329927, 9202.539873006323, 9254.629814807333, 9302.813943721088, 4906.779194936236, 4940.505949405031, 4981.352424184833, 4990.17662085759, 5168.53483186515, 3684.09739613791, 3736.3648179809497, 3806.2958352704836, 3819.656230939229, 3825.5600605930117, 641.3009819296989, 642.1331202876173, 655.4265018109154, 673.6295037729229, 678.5352033856725, 642.9903551446732, 756.7313603670727, 776.8485145396706, 780.4575819805294, 781.6638845296463, 9638.4216946982, 9797.0, 9805.509724513746, 9809.0, 10043.146332561668, 763.1681467200777, 770.8612449759097, 771.9150893401721, 778.1440415542858, 783.5768684910199, 4449.265871131227, 4648.976755116203, 4717.669763116617, 4719.575238228507, 4724.480307166209, 89829.55085224532, 122771.0, 124599.0, 129545.35227323804, 132688.0, 67514.32485675179, 74803.0, 77800.61099694579, 90184.0, 107323.46338268259, 93388.53305733428, 96269.51865240629, 97606.51196743971, 98196.0, 99010.0, 9036.59335329925, 9163.86254206174, 9244.606648019806, 9333.719988400358, 9374.390664606779, 52659.0, 53800.46199537955, 55177.0, 55180.44819551753, 56574.43425565692, 71713.0, 81414.59292703499, 81789.0, 82862.0, 84887.0, 12541.561045363369, 12611.180273282574, 12654.746905062031, 12811.423485942969, 13154.40805163789, 13227.933860330637, 13235.470581176645, 13293.135946163855, 13475.730485390433, 13503.797443038558, 11609.30344179352, 11672.766544669228, 11857.288562686266, 12129.211601246243, 12170.208936419458, 12848.743025139258, 12949.935250323688, 12966.35168241603, 13514.459421623025, 13598.456061757419, 11780.921075463988, 11861.169718119649, 11968.413096232867, 12085.697857553632, 12208.877911221129, 11018.889811101786, 11039.172062095215, 11123.769143898488, 11273.605423810128, 12026.75946481048, 9882.357646752938, 10149.23880708935, 10535.525901334306, 10591.788164236517, 10739.516721747385], "value": 7694.137490764506, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 113.0, 112.0, 116.0, 112.0, 112.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 157.0, 184.0, 140.0, 151.0, 165.0, 141.0, 181.0, 127.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 171.0, 169.0, 163.0, 163.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 159.0, 75.0, 75.0, 75.0, 76.0, 169.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 144.0, 83.0, 83.0, 85.0, 153.0, 84.0, 84.0, 139.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 57.0, 54.0, 54.0, 64.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 64.0, 62.0, 64.0, 62.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 80.0, 88.0, 80.0, 82.0, 78.0, 104.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 125.0, 122.0, 124.0, 122.0, 138.0, 121.0, 127.0, 129.0, 130.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 159.0, 159.0, 161.0, 161.0, 159.0, 157.0, 163.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 63.0, 66.0, 64.0, 64.0, 62.0, 65.0, 62.0], "value": 64.2, "unit": "score"}]}]} 19:21:02 INFO - Return code: 0 19:21:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:21:02 ERROR - # TBPL SUCCESS # 19:21:02 INFO - Running post-action listener: _resource_record_post_action 19:21:02 INFO - ##### 19:21:02 INFO - ##### Finished run-tests step (success) 19:21:02 INFO - ##### 19:21:02 INFO - Running post-run listener: _resource_record_post_run 19:21:02 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555991040; Read time: 12; Write time: 592752 19:21:02 INFO - TinderboxPrint: CPU usage
13.5% 19:21:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:21:02 INFO - TinderboxPrint: I/O write bytes / time
555,991,040 / 592,752 19:21:02 INFO - TinderboxPrint: CPU idle
8,214.0 (86.5%) 19:21:02 INFO - TinderboxPrint: CPU user
1,222.9 (12.9%) 19:21:02 INFO - TinderboxPrint: Swap in / out
0 / 0 19:21:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264224768; Read time: 0; Write time: 342144 19:21:02 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291524608; Read time: 12; Write time: 250592 19:21:02 INFO - Running post-run listener: _upload_blobber_files 19:21:02 INFO - Blob upload gear active. 19:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:21:02 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 19:21:02 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'] 19:21:02 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 19:21:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:04 INFO - (blobuploader) - INFO - Done attempting. 19:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:09 INFO - (blobuploader) - INFO - Done attempting. 19:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:10 INFO - (blobuploader) - INFO - Done attempting. 19:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:10 INFO - Return code: 0 19:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2beec020099abc75c64fea861997e20c2a0451364f8cf1eafcf6e47ae12cc2f276b37618c9a2024b3b3d0bb71a0b711dfc2347b11d1384a32d121d42481b3f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c2716a97b40a3fb7685c599fa994eab178f775459a29e80cd6063528a7c94656933954ce0a354d2ca778b77870000dab662697dca108434c856260163d2581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d81c903a59d285fcd02eae2c5790f51145030a0c5da20764ea37003a9d3b1b1cbed7b1a38d4a9be0c56eab62ade5b6a331d3586d974c9342c183f383efb124"} 19:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:10 INFO - Contents: 19:21:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2beec020099abc75c64fea861997e20c2a0451364f8cf1eafcf6e47ae12cc2f276b37618c9a2024b3b3d0bb71a0b711dfc2347b11d1384a32d121d42481b3f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c2716a97b40a3fb7685c599fa994eab178f775459a29e80cd6063528a7c94656933954ce0a354d2ca778b77870000dab662697dca108434c856260163d2581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d81c903a59d285fcd02eae2c5790f51145030a0c5da20764ea37003a9d3b1b1cbed7b1a38d4a9be0c56eab62ade5b6a331d3586d974c9342c183f383efb124"} 19:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:10 INFO - Copying logs to upload dir... 19:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.167940 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-01 19:21:09.940133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:21:09.943945) ========= 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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 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/2beec020099abc75c64fea861997e20c2a0451364f8cf1eafcf6e47ae12cc2f276b37618c9a2024b3b3d0bb71a0b711dfc2347b11d1384a32d121d42481b3f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c2716a97b40a3fb7685c599fa994eab178f775459a29e80cd6063528a7c94656933954ce0a354d2ca778b77870000dab662697dca108434c856260163d2581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d81c903a59d285fcd02eae2c5790f51145030a0c5da20764ea37003a9d3b1b1cbed7b1a38d4a9be0c56eab62ade5b6a331d3586d974c9342c183f383efb124"} build_url:https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/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/2beec020099abc75c64fea861997e20c2a0451364f8cf1eafcf6e47ae12cc2f276b37618c9a2024b3b3d0bb71a0b711dfc2347b11d1384a32d121d42481b3f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1c2716a97b40a3fb7685c599fa994eab178f775459a29e80cd6063528a7c94656933954ce0a354d2ca778b77870000dab662697dca108434c856260163d2581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d81c903a59d285fcd02eae2c5790f51145030a0c5da20764ea37003a9d3b1b1cbed7b1a38d4a9be0c56eab62ade5b6a331d3586d974c9342c183f383efb124"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:21:09.969978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:21:09.970317) ========= 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=db0483c52d987ecb441a263b000001ad-1464829911.157784-1452712511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:21:10.053950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:21:10.054300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:21:10.054662) ========= ========= Total master_lag: 0.17 =========