builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1464833389.24 results: success (0) buildid: 20160601163037 builduid: 4f596a0e8a4e45f5a0d86f7b4fd53175 revision: 23fde8ecfa91aeaa071bb19165a999b8606008f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.245311) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.245946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.246364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.261936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.262333) ========= 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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 19:09:49-- 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% 223M=0s 2016-06-01 19:09:49 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.373909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.374300) ========= 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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020547 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:49.425019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 19:09:49.425415) ========= 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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 19:09:50,020 truncating revision to first 12 chars 2016-06-01 19:09:50,020 Setting DEBUG logging. 2016-06-01 19:09:50,020 attempt 1/10 2016-06-01 19:09:50,020 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:09:51,457 unpacking tar archive at: mozilla-inbound-23fde8ecfa91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.757367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 19:09:51.197533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:51.197916) ========= script_repo_revision: 23fde8ecfa91aeaa071bb19165a999b8606008f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:51.198380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:51.198704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:09:51.208618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-01 19:09:51.208951) ========= /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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:09:51 INFO - MultiFileLogger online at 20160601 19:09:51 in /builds/slave/test 19:09:51 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:09:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:51 INFO - {'append_to_log': False, 19:09:51 INFO - 'base_work_dir': '/builds/slave/test', 19:09:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:09:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:51 INFO - 'branch': 'Mozilla-Inbound', 19:09:51 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:51 INFO - 'config_files': ('talos/linux_config.py',), 19:09:51 INFO - 'default_actions': ('clobber', 19:09:51 INFO - 'read-buildbot-config', 19:09:51 INFO - 'download-and-extract', 19:09:51 INFO - 'populate-webroot', 19:09:51 INFO - 'create-virtualenv', 19:09:51 INFO - 'install', 19:09:51 INFO - 'run-tests'), 19:09:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:51 INFO - 'download_minidump_stackwalk': True, 19:09:51 INFO - 'download_symbols': 'ondemand', 19:09:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:51 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:51 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:51 INFO - 'installer_path': 'installer.exe', 19:09:51 INFO - 'log_level': 'info', 19:09:51 INFO - 'log_name': 'talos', 19:09:51 INFO - 'log_to_console': True, 19:09:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:09:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:09:51 INFO - 'opt_config_files': (), 19:09:51 INFO - 'pip_index': False, 19:09:51 INFO - 'sps_profile': False, 19:09:51 INFO - 'sps_profile_interval': 0, 19:09:51 INFO - 'suite': 'dromaeojs-e10s', 19:09:51 INFO - 'system_bits': '32', 19:09:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:51 INFO - 'title': 'talos-linux64-ix-007', 19:09:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:51 INFO - 'use_talos_json': True, 19:09:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:51 INFO - 'work_dir': 'build'} 19:09:51 INFO - ##### 19:09:51 INFO - ##### Running clobber step. 19:09:51 INFO - ##### 19:09:51 INFO - Running pre-action listener: _resource_record_pre_action 19:09:51 INFO - Running main action method: clobber 19:09:51 INFO - rmtree: /builds/slave/test/build 19:09:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:52 INFO - Running post-action listener: _resource_record_post_action 19:09:52 INFO - ##### 19:09:52 INFO - ##### Finished clobber step (success) 19:09:52 INFO - ##### 19:09:52 INFO - ##### 19:09:52 INFO - ##### Running read-buildbot-config step. 19:09:52 INFO - ##### 19:09:52 INFO - Running pre-action listener: _resource_record_pre_action 19:09:52 INFO - Running main action method: read_buildbot_config 19:09:52 INFO - Using buildbot properties: 19:09:52 INFO - { 19:09:52 INFO - "project": "", 19:09:52 INFO - "product": "firefox", 19:09:52 INFO - "script_repo_revision": "production", 19:09:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:09:52 INFO - "repository": "", 19:09:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:09:52 INFO - "buildid": "20160601163037", 19:09:52 INFO - "pgo_build": "True", 19:09:52 INFO - "basedir": "/builds/slave/test", 19:09:52 INFO - "buildnumber": 1110, 19:09:52 INFO - "slavename": "talos-linux64-ix-007", 19:09:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:09:52 INFO - "platform": "ubuntu64_hw", 19:09:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:09:52 INFO - "branch": "mozilla-inbound", 19:09:52 INFO - "repo_path": "integration/mozilla-inbound", 19:09:52 INFO - "revision": "23fde8ecfa91aeaa071bb19165a999b8606008f1", 19:09:52 INFO - "stage_platform": "linux64-pgo", 19:09:52 INFO - "builduid": "4f596a0e8a4e45f5a0d86f7b4fd53175", 19:09:52 INFO - "slavebuilddir": "test" 19:09:52 INFO - } 19:09:52 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:09:52 INFO - Running post-action listener: _resource_record_post_action 19:09:52 INFO - ##### 19:09:52 INFO - ##### Finished read-buildbot-config step (success) 19:09:52 INFO - ##### 19:09:52 INFO - ##### 19:09:52 INFO - ##### Running download-and-extract step. 19:09:52 INFO - ##### 19:09:52 INFO - Running pre-action listener: _resource_record_pre_action 19:09:52 INFO - Running main action method: download_and_extract 19:09:52 INFO - mkdir: /builds/slave/test/build/tests 19:09: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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:54 INFO - Downloaded 1361 bytes. 19:09:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:09:54 INFO - Using the following test package requirements: 19:09:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:09:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:09:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'jsshell-linux-x86_64.zip'], 19:09:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:09:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:09:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:09:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:09:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:09:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:09: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:09:54 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:09:54 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:09:54 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:09:54 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:09:54 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:09:58 INFO - Downloaded 24423222 bytes. 19:09:58 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:09:58 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:09:59 INFO - Return code: 0 19:09:59 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:09:59 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:09:59 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:09:59 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:09:59 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:09:59 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:09:59 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:10:04 INFO - Downloaded 24423222 bytes. 19:10:04 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:10:04 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:10:06 INFO - Return code: 0 19:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:07 INFO - Downloaded 10834055 bytes. 19:10:07 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:10:07 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:10:07 INFO - Return code: 0 19:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:07 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:10:07 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:10:07 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:10:07 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:10:07 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:10:08 INFO - Downloaded 59068233 bytes. 19:10:08 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:10:08 INFO - mkdir: /builds/slave/test/properties 19:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:08 INFO - Contents: 19:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GTqQS41PReaw2Ru0XPO7DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:09 INFO - Running post-action listener: _resource_record_post_action 19:10:09 INFO - Running post-action listener: set_extra_try_arguments 19:10:09 INFO - ##### 19:10:09 INFO - ##### Finished download-and-extract step (success) 19:10:09 INFO - ##### 19:10:09 INFO - ##### 19:10:09 INFO - ##### Running populate-webroot step. 19:10:09 INFO - ##### 19:10:09 INFO - Running pre-action listener: _resource_record_pre_action 19:10:09 INFO - Running main action method: populate_webroot 19:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:09 INFO - '--tppagecycles', 19:10:09 INFO - '7'], 19:10:09 INFO - 'tests': ['tsvgm']}}, 19:10:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['damp', 'tps']}, 19:10:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'tests': ['damp', 'tps']}, 19:10:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['dromaeo_dom']}, 19:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['a11yr', 19:10:09 INFO - 'ts_paint', 19:10:09 INFO - 'tpaint', 19:10:09 INFO - 'sessionrestore', 19:10:09 INFO - 'sessionrestore_no_auto_restore', 19:10:09 INFO - 'tabpaint']}, 19:10:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['tsvgx', 19:10:09 INFO - 'tsvgr_opacity', 19:10:09 INFO - 'tart', 19:10:09 INFO - 'tscrollx', 19:10:09 INFO - 'cart']}, 19:10:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:09 INFO - 'tsvgr_opacity', 19:10:09 INFO - 'tart', 19:10:09 INFO - 'tscrollx', 19:10:09 INFO - 'cart']}, 19:10:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'talos_options': ['--disable-e10s'], 19:10:09 INFO - 'tests': ['tp5o']}, 19:10:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'tests': ['tp5o']}, 19:10:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'talos_options': ['--disable-e10s', 19:10:09 INFO - '--xperf_path', 19:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:09 INFO - 'tests': ['tp5n']}, 19:10:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:09 INFO - 'talos_options': ['--xperf_path', 19:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:09 INFO - 'tests': ['tp5n']}}, 19:10:09 INFO - 'talos.zip': {'path': '', 19:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:09 INFO - Running post-action listener: _resource_record_post_action 19:10:09 INFO - ##### 19:10:09 INFO - ##### Finished populate-webroot step (success) 19:10:09 INFO - ##### 19:10:09 INFO - ##### 19:10:09 INFO - ##### Running create-virtualenv step. 19:10:09 INFO - ##### 19:10:09 INFO - Running pre-action listener: _resource_record_pre_action 19:10:09 INFO - Running main action method: create_virtualenv 19:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:09 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:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:09 INFO - Using real prefix '/usr' 19:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:12 INFO - Installing pip.................done. 19:10:12 INFO - Return code: 0 19:10:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:12 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:10:12 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:10:12 INFO - Using env: {'DISPLAY': ':0', 19:10:12 INFO - 'HOME': '/home/cltbld', 19:10:12 INFO - 'LANG': 'en_US.UTF-8', 19:10:12 INFO - 'LANGUAGE': 'en_US:en', 19:10:12 INFO - 'LOGNAME': 'cltbld', 19:10:12 INFO - 'MAIL': '/var/mail/cltbld', 19:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:12 INFO - 'MOZ_NO_REMOTE': '1', 19:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:12 INFO - 'NO_EM_RESTART': '1', 19:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:12 INFO - 'PWD': '/builds/slave/test', 19:10:12 INFO - 'SHELL': '/bin/bash', 19:10:12 INFO - 'SHLVL': '1', 19:10:12 INFO - 'TERM': 'linux', 19:10:12 INFO - 'TMOUT': '86400', 19:10:12 INFO - 'USER': 'cltbld', 19:10:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:12 INFO - '_': '/tools/buildbot/bin/python'} 19:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:12 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:10:12 INFO - Cleaning up... 19:10:12 INFO - Return code: 0 19:10:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:12 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:12 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:10:12 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:10:12 INFO - Using env: {'DISPLAY': ':0', 19:10:12 INFO - 'HOME': '/home/cltbld', 19:10:12 INFO - 'LANG': 'en_US.UTF-8', 19:10:12 INFO - 'LANGUAGE': 'en_US:en', 19:10:12 INFO - 'LOGNAME': 'cltbld', 19:10:12 INFO - 'MAIL': '/var/mail/cltbld', 19:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:12 INFO - 'MOZ_NO_REMOTE': '1', 19:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:12 INFO - 'NO_EM_RESTART': '1', 19:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:12 INFO - 'PWD': '/builds/slave/test', 19:10:12 INFO - 'SHELL': '/bin/bash', 19:10:12 INFO - 'SHLVL': '1', 19:10:12 INFO - 'TERM': 'linux', 19:10:12 INFO - 'TMOUT': '86400', 19:10:12 INFO - 'USER': 'cltbld', 19:10:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:12 INFO - '_': '/tools/buildbot/bin/python'} 19:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:12 INFO - Downloading/unpacking psutil>=3.1.1 19:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:14 INFO - Installing collected packages: psutil 19:10:14 INFO - Running setup.py install for psutil 19:10:14 INFO - building 'psutil._psutil_linux' extension 19:10:14 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:10:14 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:10:14 INFO - building 'psutil._psutil_posix' extension 19:10:14 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:10:15 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:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:15 INFO - Successfully installed psutil 19:10:15 INFO - Cleaning up... 19:10:15 INFO - Return code: 0 19:10:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10:15 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:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:15 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:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:15 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:15 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:10:15 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:10:15 INFO - Using env: {'DISPLAY': ':0', 19:10:15 INFO - 'HOME': '/home/cltbld', 19:10:15 INFO - 'LANG': 'en_US.UTF-8', 19:10:15 INFO - 'LANGUAGE': 'en_US:en', 19:10:15 INFO - 'LOGNAME': 'cltbld', 19:10:15 INFO - 'MAIL': '/var/mail/cltbld', 19:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:15 INFO - 'MOZ_NO_REMOTE': '1', 19:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:15 INFO - 'NO_EM_RESTART': '1', 19:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:15 INFO - 'PWD': '/builds/slave/test', 19:10:15 INFO - 'SHELL': '/bin/bash', 19:10:15 INFO - 'SHLVL': '1', 19:10:15 INFO - 'TERM': 'linux', 19:10:15 INFO - 'TMOUT': '86400', 19:10:15 INFO - 'USER': 'cltbld', 19:10:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:15 INFO - '_': '/tools/buildbot/bin/python'} 19:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:15 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:10:15 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:10:15 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:10:15 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:10:15 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:10:15 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:10:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:17 INFO - Installing collected packages: mozsystemmonitor 19:10:17 INFO - Running setup.py install for mozsystemmonitor 19:10:17 INFO - Successfully installed mozsystemmonitor 19:10:17 INFO - Cleaning up... 19:10:17 INFO - Return code: 0 19:10:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:17 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:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:17 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:10:17 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:10:17 INFO - Using env: {'DISPLAY': ':0', 19:10:17 INFO - 'HOME': '/home/cltbld', 19:10:17 INFO - 'LANG': 'en_US.UTF-8', 19:10:17 INFO - 'LANGUAGE': 'en_US:en', 19:10:17 INFO - 'LOGNAME': 'cltbld', 19:10:17 INFO - 'MAIL': '/var/mail/cltbld', 19:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:17 INFO - 'MOZ_NO_REMOTE': '1', 19:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:17 INFO - 'NO_EM_RESTART': '1', 19:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:17 INFO - 'PWD': '/builds/slave/test', 19:10:17 INFO - 'SHELL': '/bin/bash', 19:10:17 INFO - 'SHLVL': '1', 19:10:17 INFO - 'TERM': 'linux', 19:10:17 INFO - 'TMOUT': '86400', 19:10:17 INFO - 'USER': 'cltbld', 19:10:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:17 INFO - '_': '/tools/buildbot/bin/python'} 19:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:17 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:20 INFO - Downloading docopt-0.6.1.tar.gz 19:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:20 INFO - Running setup.py install for blobuploader 19:10:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:20 INFO - Running setup.py install for requests 19:10:20 INFO - Running setup.py install for docopt 19:10:20 INFO - Successfully installed blobuploader requests docopt 19:10:20 INFO - Cleaning up... 19:10:21 INFO - Return code: 0 19:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:21 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:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:21 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:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:21 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:21 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:10:21 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:10:21 INFO - Using env: {'DISPLAY': ':0', 19:10:21 INFO - 'HOME': '/home/cltbld', 19:10:21 INFO - 'LANG': 'en_US.UTF-8', 19:10:21 INFO - 'LANGUAGE': 'en_US:en', 19:10:21 INFO - 'LOGNAME': 'cltbld', 19:10:21 INFO - 'MAIL': '/var/mail/cltbld', 19:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:21 INFO - 'MOZ_NO_REMOTE': '1', 19:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:21 INFO - 'NO_EM_RESTART': '1', 19:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:21 INFO - 'PWD': '/builds/slave/test', 19:10:21 INFO - 'SHELL': '/bin/bash', 19:10:21 INFO - 'SHLVL': '1', 19:10:21 INFO - 'TERM': 'linux', 19:10:21 INFO - 'TMOUT': '86400', 19:10:21 INFO - 'USER': 'cltbld', 19:10:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:21 INFO - '_': '/tools/buildbot/bin/python'} 19:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:21 INFO - Running setup.py (path:/tmp/pip-WOZgYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:21 INFO - Running setup.py (path:/tmp/pip-kWIKHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:21 INFO - Running setup.py (path:/tmp/pip-BEvjot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:21 INFO - Running setup.py (path:/tmp/pip-Zc1vWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:21 INFO - Running setup.py (path:/tmp/pip-1H3hGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:21 INFO - Running setup.py (path:/tmp/pip-7dhXvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:21 INFO - Running setup.py (path:/tmp/pip-ckVugb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:21 INFO - Running setup.py (path:/tmp/pip-q_vjMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:21 INFO - Running setup.py (path:/tmp/pip-2qDcYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:21 INFO - Running setup.py (path:/tmp/pip-klZztJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:21 INFO - Running setup.py (path:/tmp/pip-0HgWaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:22 INFO - Running setup.py (path:/tmp/pip-3pKCDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:22 INFO - Running setup.py (path:/tmp/pip-JBoTwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:22 INFO - Running setup.py (path:/tmp/pip-yyv6zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:22 INFO - Running setup.py (path:/tmp/pip-_YUdN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:22 INFO - Running setup.py (path:/tmp/pip-3MXTN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:22 INFO - Running setup.py (path:/tmp/pip-ZWLD0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:22 INFO - Running setup.py install for manifestparser 19:10:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:22 INFO - Running setup.py install for mozcrash 19:10:22 INFO - Running setup.py install for mozdebug 19:10:22 INFO - Running setup.py install for mozdevice 19:10:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:22 INFO - Running setup.py install for mozfile 19:10:22 INFO - Running setup.py install for mozhttpd 19:10:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozinfo 19:10:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozInstall 19:10:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozleak 19:10:23 INFO - Running setup.py install for mozlog 19:10:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for moznetwork 19:10:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozprocess 19:10:23 INFO - Running setup.py install for mozprofile 19:10:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozrunner 19:10:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:23 INFO - Running setup.py install for mozscreenshot 19:10:24 INFO - Running setup.py install for moztest 19:10:24 INFO - Running setup.py install for mozversion 19:10:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:24 INFO - Cleaning up... 19:10:24 INFO - Return code: 0 19:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:24 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:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:24 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:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:24 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:24 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:10:24 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:10:24 INFO - Using env: {'DISPLAY': ':0', 19:10:24 INFO - 'HOME': '/home/cltbld', 19:10:24 INFO - 'LANG': 'en_US.UTF-8', 19:10:24 INFO - 'LANGUAGE': 'en_US:en', 19:10:24 INFO - 'LOGNAME': 'cltbld', 19:10:24 INFO - 'MAIL': '/var/mail/cltbld', 19:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:24 INFO - 'MOZ_NO_REMOTE': '1', 19:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:24 INFO - 'NO_EM_RESTART': '1', 19:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:24 INFO - 'PWD': '/builds/slave/test', 19:10:24 INFO - 'SHELL': '/bin/bash', 19:10:24 INFO - 'SHLVL': '1', 19:10:24 INFO - 'TERM': 'linux', 19:10:24 INFO - 'TMOUT': '86400', 19:10:24 INFO - 'USER': 'cltbld', 19:10:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:24 INFO - '_': '/tools/buildbot/bin/python'} 19:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:24 INFO - Running setup.py (path:/tmp/pip-Kw1e7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:24 INFO - Running setup.py (path:/tmp/pip-ihNsyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:24 INFO - Running setup.py (path:/tmp/pip-gtJUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:24 INFO - Running setup.py (path:/tmp/pip-cdUGvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:24 INFO - Running setup.py (path:/tmp/pip-xLJpfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:24 INFO - Running setup.py (path:/tmp/pip-ndFlAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:24 INFO - Running setup.py (path:/tmp/pip-v620lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:24 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:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:24 INFO - Running setup.py (path:/tmp/pip-XiOYuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:25 INFO - Running setup.py (path:/tmp/pip-NnSlSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:25 INFO - Running setup.py (path:/tmp/pip-FOAl24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:25 INFO - Running setup.py (path:/tmp/pip-yYrVAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:25 INFO - Running setup.py (path:/tmp/pip-9Ci6u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:25 INFO - Running setup.py (path:/tmp/pip-EQzBm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:25 INFO - Running setup.py (path:/tmp/pip-5L8dX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:25 INFO - Running setup.py (path:/tmp/pip-L20szg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:25 INFO - Running setup.py (path:/tmp/pip-QbNJPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:25 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:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:25 INFO - Running setup.py (path:/tmp/pip-rakCNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:27 INFO - Downloading blessings-1.6.tar.gz 19:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:27 INFO - Installing collected packages: blessings 19:10:27 INFO - Running setup.py install for blessings 19:10:27 INFO - Successfully installed blessings 19:10:27 INFO - Cleaning up... 19:10:27 INFO - Return code: 0 19:10:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:28 INFO - Reading from file tmpfile_stdout 19:10:28 INFO - Current package versions: 19:10:28 INFO - argparse == 1.2.1 19:10:28 INFO - blessings == 1.6 19:10:28 INFO - blobuploader == 1.2.4 19:10:28 INFO - docopt == 0.6.1 19:10:28 INFO - manifestparser == 1.1 19:10:28 INFO - mozInstall == 1.12 19:10:28 INFO - mozcrash == 0.17 19:10:28 INFO - mozdebug == 0.1 19:10:28 INFO - mozdevice == 0.48 19:10:28 INFO - mozfile == 1.2 19:10:28 INFO - mozhttpd == 0.7 19:10:28 INFO - mozinfo == 0.9 19:10:28 INFO - mozleak == 0.1 19:10:28 INFO - mozlog == 3.2 19:10:28 INFO - moznetwork == 0.27 19:10:28 INFO - mozprocess == 0.22 19:10:28 INFO - mozprofile == 0.28 19:10:28 INFO - mozrunner == 6.11 19:10:28 INFO - mozscreenshot == 0.1 19:10:28 INFO - mozsystemmonitor == 0.3 19:10:28 INFO - moztest == 0.7 19:10:28 INFO - mozversion == 1.4 19:10:28 INFO - psutil == 3.1.1 19:10:28 INFO - requests == 1.2.3 19:10:28 INFO - wsgiref == 0.1.2 19:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:28 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:28 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:10:28 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:10:28 INFO - Using env: {'DISPLAY': ':0', 19:10:28 INFO - 'HOME': '/home/cltbld', 19:10:28 INFO - 'LANG': 'en_US.UTF-8', 19:10:28 INFO - 'LANGUAGE': 'en_US:en', 19:10:28 INFO - 'LOGNAME': 'cltbld', 19:10:28 INFO - 'MAIL': '/var/mail/cltbld', 19:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:28 INFO - 'MOZ_NO_REMOTE': '1', 19:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:28 INFO - 'NO_EM_RESTART': '1', 19:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:28 INFO - 'PWD': '/builds/slave/test', 19:10:28 INFO - 'SHELL': '/bin/bash', 19:10:28 INFO - 'SHLVL': '1', 19:10:28 INFO - 'TERM': 'linux', 19:10:28 INFO - 'TMOUT': '86400', 19:10:28 INFO - 'USER': 'cltbld', 19:10:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:28 INFO - '_': '/tools/buildbot/bin/python'} 19:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 INFO - Cleaning up... 19:10:28 INFO - Return code: 0 19:10:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10: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:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:28 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:28 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:10:28 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:10:28 INFO - Using env: {'DISPLAY': ':0', 19:10:28 INFO - 'HOME': '/home/cltbld', 19:10:28 INFO - 'LANG': 'en_US.UTF-8', 19:10:28 INFO - 'LANGUAGE': 'en_US:en', 19:10:28 INFO - 'LOGNAME': 'cltbld', 19:10:28 INFO - 'MAIL': '/var/mail/cltbld', 19:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:28 INFO - 'MOZ_NO_REMOTE': '1', 19:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:28 INFO - 'NO_EM_RESTART': '1', 19:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:28 INFO - 'PWD': '/builds/slave/test', 19:10:28 INFO - 'SHELL': '/bin/bash', 19:10:28 INFO - 'SHLVL': '1', 19:10:28 INFO - 'TERM': 'linux', 19:10:28 INFO - 'TMOUT': '86400', 19:10:28 INFO - 'USER': 'cltbld', 19:10:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:28 INFO - '_': '/tools/buildbot/bin/python'} 19:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:28 INFO - Downloading/unpacking jsonschema 19:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:30 INFO - Downloading/unpacking functools32 (from jsonschema) 19:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:30 INFO - warning: no files found matching '*.txt' 19:10:30 INFO - no previously-included directories found matching 'build' 19:10:30 INFO - no previously-included directories found matching 'dist' 19:10:30 INFO - no previously-included directories found matching '.git*' 19:10:30 INFO - Installing collected packages: jsonschema, functools32 19:10:30 INFO - Running setup.py install for functools32 19:10:30 INFO - warning: no files found matching '*.txt' 19:10:30 INFO - no previously-included directories found matching 'build' 19:10:30 INFO - no previously-included directories found matching 'dist' 19:10:30 INFO - no previously-included directories found matching '.git*' 19:10:30 INFO - Successfully installed jsonschema functools32 19:10:30 INFO - Cleaning up... 19:10:30 INFO - Return code: 0 19:10:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:10:30 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:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:30 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:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:30 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 0x7f10f298af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, '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': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', '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:10:30 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:10:30 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:10:30 INFO - Using env: {'DISPLAY': ':0', 19:10:30 INFO - 'HOME': '/home/cltbld', 19:10:30 INFO - 'LANG': 'en_US.UTF-8', 19:10:30 INFO - 'LANGUAGE': 'en_US:en', 19:10:30 INFO - 'LOGNAME': 'cltbld', 19:10:30 INFO - 'MAIL': '/var/mail/cltbld', 19:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:30 INFO - 'MOZ_NO_REMOTE': '1', 19:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:30 INFO - 'NO_EM_RESTART': '1', 19:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:30 INFO - 'PWD': '/builds/slave/test', 19:10:30 INFO - 'SHELL': '/bin/bash', 19:10:30 INFO - 'SHLVL': '1', 19:10:30 INFO - 'TERM': 'linux', 19:10:30 INFO - 'TMOUT': '86400', 19:10:30 INFO - 'USER': 'cltbld', 19:10:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:30 INFO - '_': '/tools/buildbot/bin/python'} 19:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:31 INFO - Downloading/unpacking flake8 19:10:31 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:10:31 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:10:31 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:10:31 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:10:31 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:10:31 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:10:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:10:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:10:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:33 INFO - no previously-included directories found matching 'docs/_build' 19:10:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:10:33 INFO - Running setup.py install for pep8 19:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:33 INFO - no previously-included directories found matching 'docs/_build' 19:10:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:10:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:10:33 INFO - Cleaning up... 19:10:33 INFO - Return code: 0 19:10:33 INFO - Running post-action listener: _resource_record_post_action 19:10:33 INFO - Running post-action listener: _start_resource_monitoring 19:10:33 INFO - Starting resource monitoring. 19:10:33 INFO - ##### 19:10:33 INFO - ##### Finished create-virtualenv step (success) 19:10:33 INFO - ##### 19:10:33 INFO - ##### 19:10:33 INFO - ##### Running install step. 19:10:33 INFO - ##### 19:10:33 INFO - Running pre-action listener: _resource_record_pre_action 19:10:33 INFO - Running main action method: install 19:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:34 INFO - Reading from file tmpfile_stdout 19:10:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:34 INFO - Reading from file tmpfile_stdout 19:10:34 INFO - Output received: 19:10:34 INFO - Usage: mozinstall [options] installer 19:10:34 INFO - Options: 19:10:34 INFO - -h, --help show this help message and exit 19:10:34 INFO - -d DEST, --destination=DEST 19:10:34 INFO - Directory to install application into. [default: 19:10:34 INFO - "/builds/slave/test"] 19:10:34 INFO - --app=APP Application being installed. [default: firefox] 19:10:34 INFO - mkdir: /builds/slave/test/build/application 19:10:34 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:10:34 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:10:51 INFO - Reading from file tmpfile_stdout 19:10:51 INFO - Output received: 19:10:51 INFO - /builds/slave/test/build/application/firefox/firefox 19:10:51 INFO - Running post-action listener: _resource_record_post_action 19:10:51 INFO - ##### 19:10:51 INFO - ##### Finished install step (success) 19:10:51 INFO - ##### 19:10:51 INFO - ##### 19:10:51 INFO - ##### Running run-tests step. 19:10:51 INFO - ##### 19:10:51 INFO - Running pre-action listener: _resource_record_pre_action 19:10:51 INFO - Running main action method: run_tests 19:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:51 INFO - Python 2.7.3 19:10:51 INFO - Return code: 0 19:10:51 INFO - grabbing minidump binary from tooltool 19:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:51 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 0xf0a9c0>, '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 0xf0b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf0bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:51 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:10:51 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:10:51 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:10:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:51 INFO - Return code: 0 19:10:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:10:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:10:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:52 INFO - Return code: 0 19:10:52 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-007', '--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:10:52 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-007 --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:10:52 INFO - Using env: {'DISPLAY': ':0', 19:10:52 INFO - 'HOME': '/home/cltbld', 19:10:52 INFO - 'LANG': 'en_US.UTF-8', 19:10:52 INFO - 'LANGUAGE': 'en_US:en', 19:10:52 INFO - 'LOGNAME': 'cltbld', 19:10:52 INFO - 'MAIL': '/var/mail/cltbld', 19:10:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:52 INFO - 'MOZ_NO_REMOTE': '1', 19:10:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:52 INFO - 'NO_EM_RESTART': '1', 19:10:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:52 INFO - 'PWD': '/builds/slave/test', 19:10:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:52 INFO - 'SHELL': '/bin/bash', 19:10:52 INFO - 'SHLVL': '1', 19:10:52 INFO - 'TERM': 'linux', 19:10:52 INFO - 'TMOUT': '86400', 19:10:52 INFO - 'USER': 'cltbld', 19:10:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464825524.726497-293408401', 19:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:52 INFO - '_': '/tools/buildbot/bin/python'} 19:10:52 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-007', '--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:10:52 INFO - mozversion application_buildid: 20160601163037 19:10:52 INFO - mozversion application_changeset: 23fde8ecfa91aeaa071bb19165a999b8606008f1 19:10:52 INFO - mozversion application_display_name: Nightly 19:10:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:52 INFO - mozversion application_name: Firefox 19:10:52 INFO - mozversion application_remotingname: firefox 19:10:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:10:52 INFO - mozversion application_vendor: Mozilla 19:10:52 INFO - mozversion application_version: 49.0a1 19:10:52 INFO - mozversion platform_buildid: 20160601163037 19:10:52 INFO - mozversion platform_changeset: 23fde8ecfa91aeaa071bb19165a999b8606008f1 19:10:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:10:52 INFO - mozversion platform_version: 49.0a1 19:10:52 INFO - using testdate: 1464833452 19:10:52 INFO - actual date: 1464833452 19:10:52 INFO - starting webserver on 'localhost:40275' 19:10:52 INFO - SUITE-START | Running 2 tests 19:10:52 INFO - TEST-START | dromaeo_css 19:10:52 INFO - operating with platform_type : linux_ 19:10:52 INFO - Initialising browser for dromaeo_css test... 19:10:52 INFO - TEST-INFO | started process 8518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCVRgC0/profile http://localhost:40275/getInfo.html) 19:10:56 INFO - PROCESS | 8518 | __metrics Screen width/height:1600/1200 19:10:56 INFO - PROCESS | 8518 | colorDepth:24 19:10:56 INFO - PROCESS | 8518 | Browser inner width/height: 1024/697 19:10:56 INFO - PROCESS | 8518 | __metrics 19:10:56 ERROR - PROCESS | 8518 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:10:57 INFO - TEST-INFO | 8518: exit 0 19:10:57 INFO - Browser initialized. 19:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:57 INFO - TEST-INFO | started process 8637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCVRgC0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:09 INFO - PROCESS | 8637 | RSS: Main: 167284736 19:11:09 INFO - PROCESS | 8637 | 19:11:59 INFO - PROCESS | 8637 | 1464833519121 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:14:06 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40275/tests/dromaeo/cssquery-ext.html) 19:14:07 INFO - PROCESS | 8637 | RSS: Main: 170110976 19:14:07 INFO - PROCESS | 8637 | 19:17:10 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-ext.html (next: http://localhost:40275/tests/dromaeo/cssquery-jquery.html) 19:17:10 INFO - PROCESS | 8637 | RSS: Main: 169943040 19:17:10 INFO - PROCESS | 8637 | 19:20:12 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40275/tests/dromaeo/cssquery-mootools.html) 19:20:13 INFO - PROCESS | 8637 | RSS: Main: 171159552 19:20:13 INFO - PROCESS | 8637 | 19:23:14 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40275/tests/dromaeo/cssquery-prototype.html) 19:23:15 INFO - PROCESS | 8637 | RSS: Main: 168148992 19:23:15 INFO - PROCESS | 8637 | 19:26:17 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40275/tests/dromaeo/cssquery-yui.html) 19:26:18 INFO - PROCESS | 8637 | RSS: Main: 170209280 19:26:18 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | Cycle 1(1): loaded http://localhost:40275/tests/dromaeo/cssquery-yui.html (next: http://localhost:40275/tests/dromaeo/cssquery-dojo.html) 19:29:21 INFO - PROCESS | 8637 | RSS: Main: 170786816 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | __start_tp_report 19:29:21 INFO - PROCESS | 8637 | _x_x_mozilla_page_load 19:29:21 INFO - PROCESS | 8637 | _x_x_mozilla_page_load_details 19:29:21 INFO - PROCESS | 8637 | |i|pagename|runs| 19:29:21 INFO - PROCESS | 8637 | |0;dojo.html;3119.62564492261;3168.3980043791694;3181.5068664357027;3215.099772063823;3216.5175223716456;5500.724963751812;5523.806666766664;5557.333120025598;5635.63368381055;5638.40796716345;5375.43557926418;5454.34547854257;5498.725063746817;5531.944680553193;5534.806281780138;5008.098542262401;5022.974885125569;5122.3084883540805;5126.5642420394315;5210.348706411699;851.0760545981444;4893.632977526682;4935.950640493603;5072.213806859942;5085.567726743213;5008.7996480140755;5013.097642424362;5047.570956468705;5061.721605311706;5067.74661266937;5063.316452278932;5074.873128171788;5084;5084.415292241366;5087.974560127176;4914.606831453475;4968;4975.776090075955;5020.2218656108;5062.392512898439;5403.486668766461;5436.836894893159;5444.8366549003595;5461.590380721462;5488.4237155098535;5767.682777447239;5804.506616937565;5918.970405147989;6006.489448396892;6011.849703757397;5973.880522389528;5988.19159413478;6010.2186715726675;6061.454469097803;6063.848403789941;5602.131669591261;5606.299212598426;5614.410486898899;5644.802431914904;5648.943510564883;5792.88414231713;5841.7371218295275;6161.7535298588455;6177.536684748572;6186.257649082049;5710.3433105193435;5822.475977162076;5910.054391297458;5950.107483877453;5992.0712289595185;5984.640921544721;6041.365656606081;6044.03295472731;6057.303410107894;6068.059450785136;5779.768809247667;5980.73086711099;6051.334353221142;6057.030875059969;6061.878762424727;5888.61723987948;5946.137810017523;5971.7611295547695;6010.158577799111;6011.3086994995265;4291.6137547620865;4313.827446902152;4316.892077698083;4317.201317756225;4359.2807186813825;3783.3000894834545;3805.904852378713;3856.2287542491613;3896.59085795993;3902.5316961964745;5533.3083364579425;5585.832425027255;5612.961602103624;5643.5767317451355;5647.407022262603;5915.053591425351;6001.639901605918;6008.279006519158;6012.609180403259;6014.8195554133445;5698.059820129715;5699.971500142473;5704.1443783432815;5762.1068734346245;5786.334571524329;4969.055879382906;5003.049420610072;5042.042012017705;5042.117629414838;5077.720725360141;6000.519958403404;6216.564840461215;6253.6560489173535;6268.153799237136;6268.874622507525;5924.881502369843;5970.253718285127;5995.310539288038;6042.486388656837;6068.241469816273;6180.567360284737;6211.9068213977735;6219.875602487835;6220.875582488235;6236.501079913505;5766.163906233656;5837.562182836219;5931.851703707442;5936.079907614154;5989.580729348903;5892.558058145742;5915.526757859275;5934.495567876779;5985.40145985398;6016.699165041818;5793.652380857162;5824.039033559585;5824.825255242349;5829.562782791223;5834.38738932406;5660.462256085665;5699.173619825185;5719.971400142973;5801.883962320646;5808.970955145197;5597.412271711411;5636.85907852307;5661.122526008476;5669.206311116364;5771.2208851806145;5802.50678692299;5893.764249430146;5909.409059094056;5911.467967882912;5922.289325280994;5547.195656629686;5726.713664316851;5754.108113242454;5754.53963682896;5765.971170144123 19:29:21 INFO - PROCESS | 8637 | |1;ext.html;582.4030368871905;629.433509841143;646.2632598837323;646.689588997281;648.1315037849284;42629.36055959163;44011.11977760443;44141.77929110354;44282.557174428286;47639.52360476394;42420.15159696804;42707.359389609104;42748;42824;42882.142357152916;8775.429597076201;8930.642774289021;8957.149070838292;8968.910310896905;9006.504642244674;8817.426867253607;8832.602532886003;8951.194392504673;8956.373053886231;8990.59542320594;8933.59798809052;8947.552622368888;8969.775755606097;9019.819603607924;9037.819243615124;8899;8902.510361930092;8969.596368163384;8978.416402933788;8983.326250531203;8757.211850933383;8918.331125165638;8920.553972301424;8927.776805579848;8936;41000;41377.37933930993;41610.1677966442;41622.58377416217;41636;3427.074689833731;3617.149969757105;3734.178480734234;3786.1859700164596;3965.4250133730734;31297.687023129933;31300.37399252002;32007.199820004687;32428.837855810805;33025.50461743076;4182.811773470201;4210.768407737573;4216.3464662977285;4218;4234.724742891703;348599;349182;350760;351223;351592;57587.136192957136;57868;57911.71044144837;57936.42063579395;57976.71011644915;35855;36596;36662.8166859164;38023.80988095097;60691.69654151789;16710.66578668444;16712.916435417745;16793.91603041977;16820.411285604947;16879.40922067722;12488.12583119173;12589.24464532131;12596.937015314865;12611.432485538173;12676.873231267753;19953.60092798136;19959.20163193485;19959.301424450074;20027;20189.293374732108;7131.607761573163;7209.639518024078;7370.557766534025;7373;7394.371478424287;985.4038306824411;1022.8158931392272;1054.620336678795;1154.3362566524281;1180.734334774686;32719.199119868048;32811.343773124405;32909.50635740466;32933;33122.8343858284;1088.5700148441479;1094.0919037199105;1172.5753209850072;1178.1693905796392;1183.2722875431548;16861.494155175365;17101;17208.741868871726;17260.223289951984;17264.654706905792;611421;616223;616297;617732;619341;57895.71052144712;58559.414405856245;58627.70686146542;58822.70588647029;58835;1336.385262779113;1389.6803735140975;1394.7698629726185;1400.9369578368999;1403.9087459315112;31418.21454463657;31972.68027319697;32868.178295542806;33002.83498582492;34050.31899362049;57922.7103864478;58198.709006454694;58798.70600646969;58805.41194587999;59038;515017;517111;517319;520782;521337;44611;44700.32949505825;45853;46153.30770038385;46261.768691157675;48961.51038489569;49941.25088123754;49972;50688;50983.49016509787;42321.153576928904;42818.78590607027;43242.35136472892;43262.351064734685;43846;42213;42347.57652423436;43059.569404305556;43522.34716479192;43783;41396.586034139276;42006.579934200265;42365;42684.57315426806;42933;36995;37470.503539575424;38210.42684359681;38565.22869542649;38732.80633596814;28962.855185723936;28966;29023.541105778073;29192;29306.41387172202 19:29:21 INFO - PROCESS | 8637 | |2;jquery.html;391.9333713268743;394.9368101103824;395.2076087444675;401.17358242021436;411.5678537535589;13580.932095339534;18391.080445977714;18671.346502872402;19364.612707745855;19466.707999380003;17504.64990700185;17556.209970551325;17837.64324713505;18601.162947667355;18635.534111647215;5544.500994910457;5607.663540187592;5762.56780741444;5777.133429985493;5809.186713860063;5628.746706398222;5734.139879018139;5752.1084231943905;5764.74058667361;5780.884382312352;5486.423925487826;5671.8582035449235;5722.456366645162;5739.655620662753;5744.4829965303115;5682.630629009122;5711.971440142773;5712.514436272922;5726.455986681259;5730.140478928173;4876.926846097312;5090.720010399426;5120.283160357553;5122.129238029506;5133.281340612317;11970.940145299217;12538.373081345897;12643.810342844772;22908.54182916349;23041.654375184386;2250.234920127148;2268.319504148749;2288.084766093559;2293.0942277800177;2317.015268510893;9446.00816914221;9558.426494410358;9944.651937182163;9966.750831229205;10070.345427547187;1923.2691577200715;1953.7655481342188;1989.4429559723155;2008.7890771469079;2052.5073982244303;77272.61363693202;80342;80485;81282.59358703169;81712.59143704243;10892.128629709605;10931.01620854111;10981.560737570568;11135.387553684624;11378.54485820558;15467.303971321318;15608.609784755472;15623.687526249412;15628.609284767972;15670;7883.763487095396;8041;8074.919250807534;8229.382796290301;8239.464434811838;7663.885041724378;7822.687092516236;7890.64492097857;7974.5613991229875;8010.79973000668;4640.466346370143;4670.392848929685;4705;4800.783964721596;4815.807367705323;1914.9329773457862;1989.4727897107277;2000.1988269211477;2001.1595130045416;2052.6818343156833;904.9457032578066;989.5645915797027;1022.5654097008742;1034.1623285139062;1040.635777477892;18485.630287394444;19382.224711011684;19537.609247814966;19598.804011959983;19649.31227407034;969.1616751510035;989.7426669065951;1006.2402885821305;1018.1803648063232;1038.444432228754;10597.470126493645;10732.94633526843;10789.46052697362;10851.67444976652;10938.671839844817;496684;502678;506760;509490;513584;75180;83800;85878.57060714782;93460;96352;888.2716172738293;900.6127365233012;910.3991365698607;915.7435917942987;969.8205831921117;16705.331786728395;17070.82929170742;17244.137793110043;17333.47999560015;17589.560260993578;31622.841885790425;42002.579974201086;42439.3634095495;42466.78766606147;42843;57406;58059.4194058054;59646;60030;60464;8138.633761480866;8246.463979841292;8410.789730256793;8499.065102838806;8650.480971141751;11174.66476005721;13069.542566010525;13199;13323.533676321282;13389.062765606313;11242.437878105899;11244.381559014333;11520.481578328827;11570.247933884271;11590.652280431601;10907.781844363228;10909.236353455182;10995;11183.832242516206;11430.428478576205;8513.616887239965;11262.549498019987;11394.08847292198;11719.531218751154;12078;8224.506529608243;8335.666573337241;8336;8419.789505262417;8560.272376847788;8683.86974195375;10830.945845270724;11272.83090753623;12165.452554634885;12176.147669663038 19:29:21 INFO - PROCESS | 8637 | |3;mootools.html;1431.799548063271;1480.8000919875817;1579.9921000394995;1706.2407228783181;1738.9829493869163;8110.472819266758;8603.311735061196;8768.69309574165;9428.717138485848;9468.289878259124;9221.58502867371;9285.442873427599;9338.159565639091;9343.39267947583;9366.20387267083;2371.1937941100064;2379.1435083369975;2405.230326295586;2416.226807421626;2417.697787776528;2296.5062511560013;2341.625339945609;2355.6702061711376;2357.281029286067;2359.8466099703464;2284.0407029047756;2285.5086156476355;2303.55080759252;2308.722953245613;2322.3033090072995;2271.4548508357957;2275.5335156293004;2277.7152855893014;2299.149314753552;2300.068472268734;2293.908243670251;2313.90744370225;2317.5944209763225;2318.1654604342425;2333.288347054148;9077.092290770936;9154.267658587298;9165.954170229174;9227.215686666641;9239.168474837297;5084.567811736007;5165.147750621143;5192.974035129838;5195.480451954812;5206.895862082775;3224.4840825467813;3324.4514655081884;3333.6499667534804;3368.461046232591;3434.708049815769;1146.6789298996212;1152.3489228585822;1989.7811240763504;2017.9495512612154;2058.289889987952;12742.80885786714;12818.102732808615;12873.871261287455;12889.871101288962;12897.09720319578;4370.650347972218;4492.438445194351;4544.500104988449;4566.885827854264;4571.954280457153;10050.296479246528;10051.648192313234;10060.647877324258;10075.596976120873;10086.49567521621;5100.948990510122;5186.818461353834;5187.403448603383;5188.766505507261;5203.271541984125;4257.765822879709;4658.930116048262;4802.111609352281;4866.7079975201605;4871.269309603517;4115.691323150776;4145.79271036447;4169.731427549063;4181.811818468115;4183.6234738873645;1249.8688686738517;1256.824044633752;1263.684078980255;1273.9108262421728;1275.3623188405797;893.9553022348856;947.8530827721714;993.7565296502403;996.1532697207316;1013.0578561937322;5932.762689492372;5937.970310148422;6029.849253768691;6051.213342265477;6092.390760923872;974.8878878928872;978.5889926231;990.7374545745383;998.5157198758596;1022.5091955861228;3937.291287568265;4151.813168407429;4159.812808423628;4186.099988502426;4288.270993931039;11224;11483.25358851672;11525.423728813526;11608.187426880037;11627.069834413227;10711.892881071246;11412.600558980395;11477.598284060017;11519.942400287944;11580.073594112451;8316.584170791557;8572.614232359434;8613.741587752378;8622;8652.69715559965;5996;6123.295820980644;6127.571070025234;6212.875742485035;6320;10259.846102308322;10543.103836174012;10589.417582033062;10710.946445267724;10791.514381852992;10681.57273709043;10698.89301106979;10826.188035897496;10831.187660925305;10840.620578279722;7370;7729.497582657109;7734.33711751976;7939.364850812037;8062.274395304451;8705.173008564176;8923.598438070172;8949.642014319354;9001.504917229615;9083.818323633623;7828.256315650005;7965.392905744257;7977.08263549676;7992.36061115121;8053.073896501977;7873.921260787319;7929.5242285463055;8020.679172833022;8084.514929104273;8132.146124656826;7198.676059577437;7254.746083887038;7280.526765760209;7286.489945703962;7324.267573242846;5278.551323137576;5295.549878260391;5300.098983172793;5324.414314425333;5349.438308977501;5291.603129765206;5357.651752636066;5389.083855744611;5469.726513674221;5472.097103977958 19:29:21 INFO - PROCESS | 8637 | |4;prototype.html;330.20053522056895;341.3105526835792;346.5598689664126;349.50195970741703;352.917064489845;5480.177973304007;5615.185798059279;5622;5692.829215123547;5743.253377060982;5548.223248745179;5592.720363981794;5617.578681598886;5622.240997465341;5643.548516118711;4328.63206627437;4329.1558146161515;4354.238008348534;4386.232409328355;4389.6049355558;4137.81379837908;4331.8483853065145;4358.825646974133;4379.912401751963;4389.824407023715;4250.48994120706;4275;4295.72077814941;4302.354646802974;4309.31051031835;4334.198173337927;4354.2162410765895;4355.586219309161;4361.43301370823;4377.956220437787;3690.4833323334756;3754.2866855297407;3787.715921305913;3843.9621302248515;3858.2862170498265;5315.867103322409;5319;5322.467753224685;5324.201369794562;5326.600504962104;4913.803447862081;4929.137400954819;4934.654574179809;4959.677620954626;4997.42529609096;5534.944650553483;5808.7095645218;5865;5875.500582450454;5888.322842873039;4095.8361665533344;4109.630133287988;4113.1568028554375;4123.340265557526;4140.275451795924;6082.1789058477425;6107.862248213134;6141.938580614226;6149.108379284979;6157.507399408037;4172.937405938914;4276.893077673083;4280.892977675583;4283.2290187765875;4306.978465107654;4333.241682705514;4339.978300108479;4357.324614684729;4364.672649551233;4386.649068074546;4937.481564435682;4944.678595891256;4953.687272872619;4956.231784073474;4981.476944920803;5738.540916726652;5915.940840591625;5929.911051334234;5933.842900634421;5981.252343457068;1461.101422625099;1465.6735654232937;1465.827338129492;1491.2320155120121;1506.5856889355514;914.2229105260475;937.4515908193647;946.1437399153776;958.5782255807422;962.6775030364767;5054.368203974504;5073.670211436245;5075.289459475676;5084.8220312288895;5162.638615296968;5336.759845806948;5362.249285100089;5447.319085114361;5463.644863083887;5494.2857428534035;5014.606608503461;5026.52248036436;5040.269160971712;5101.617378696613;5146.228065790161;2800.957985630217;2854.4728570214834;2905.7239562241552;2914.533674612052;2928.677845437;5531.419200983919;5574;5575.860603484864;5579.4978451938705;5629.859253518613;5373.435789242073;5725.59920805548;6233.283172435228;6240.438360547572;6307.180066591313;6334;6341.778037768656;6343.270523889812;6385.744570217139;6396.264429590564;5887.910736513759;6108.144859719731;6126.417990290915;6171.197744293213;6200.3489633589625;5998.640081595118;6025.246844144482;6028.939710602838;6032.155498230339;6087.969560152171;6068.393160683896;6295.338989406229;6302;6364;6369.77705780314;4176.43618111551;4186.790660466903;4194.951262184454;4211.578842115887;4216.7680777557525;6130.816075517741;6179.81460556184;6212.316645169119;6225.501959843292;6261.467775238973;5808.937827071329;5949.286085669747;5976.940230597638;6009.038553831366;6096.41493211777;5887.852803679771;5944.524438045032;5953.374895635896;5965.985782416913;5971.447423669791;5621.634593751393;5778.74628894723;5787.102999035156;5838.970805145947;5844.240248767633;5942.1978032965;5948.702564871653;5955.315138758925;5959.970200149145;5987.64074155552;5819.679917604572;5824.301083869963;5832.445917637818;5854.297484301911;5862.530997520274 19:29:21 INFO - PROCESS | 8637 | |5;yui.html;752.2214507984237;758.4501236603463;776.6582703610408;832.8417600655874;856.790086428825;15591.84408155918;16359.263833127508;16389.83610163898;16917.154142292897;17450;14993.400263989428;15330.233488325595;15333.463328783495;15335;15361.15513646749;818.9590520473982;823.069930977994;823.8887750153742;824.1552408780988;825.8059356051323;693.6046453521495;795.757294025325;812.0580127052621;812.297362781196;816.7672213419177;855.0722466124263;857.4426622695266;858.107568129145;858.3519442820661;862.7454900804278;846.7713717296295;850.1371108325055;857.5540718826206;858.1590041759049;860.2687715441856;626.3266987987931;628.1927722876128;629.6442509981846;630.014028046111;632.1276638239246;15425.382984680711;15432.922835385863;15513;15514.5345639631;15539.611509712235;14576.979611427205;14834.851651483455;14934.25328733559;14983.32575034126;15217.61955951099;12388.876111238862;12408.875911240862;12417.44121514534;12536.74926501474;12678.746425071447;3884.4561761353434;3924.3328634132267;3931.5871833457645;3989.6608788252743;4015.738976966517;72014;72737.27262727411;72760.27239727588;72898;72932;11405.486753096131;11491.71270718222;11568.911296360904;11781.352025638673;11942.16404851652;19302;19450.8054919449;19483;19519.31682391138;19557.413277601696;8987.640494380283;9010.234130099016;9036.909630903738;9140.177384035469;9164.816703665889;4795.2505702702265;4798.66409351349;4892.412910450768;4950.653454258168;5157.123289040872;3515.086077619786;3629.6207441172714;3630.5824830144343;3633.0190848470766;3634.4184930411006;624.8094331229019;631.0313668518802;641.6374748267308;647.5402464250341;649.5842660697158;576.8529025098657;665.6405541007898;691.9031335613018;702.4310308650009;772.2972095393166;9216.262698984065;9528.90471095294;9565.378250413702;9586.771926159223;9612.327137100336;526.5708447615182;614.0972770028052;619.8946179149556;747.816784887706;752.1801236652076;4056.492938382702;4461.152381047591;4473.329000649928;4484.820607175741;4592.334111553806;66765.6661716698;68006.31993679999;83284.58357708172;113528;114629;96341.51829240809;97396.51301743445;97705.51147244219;99535.50232248937;101121.49439252904;69107.65446172738;84495;85592.57203714066;86511;89351.55324223338;8409.453385529921;8461;8594.742157735278;8665.870011949699;8672.913270867211;49120.50879491159;49588.25617615811;49835.25247121223;50731.746341269536;51195.48804511907;72421;76877.231227687;78237.60881195558;78312;78884.60557697175;11317.434128293387;11632.243904146204;11897.122179906197;11966.880331196577;12742.299173545543;12694.809577856155;12931.741365172831;13321.441561741774;13624.250666213056;14284;11882.16824822254;11969.401529923643;12146.696332591757;12186.878131218575;12347.320897350732;12669.683257918627;12687.80968285495;13254.734905302033;13258.602241932758;13267.734645306848;11550;11732.178747487595;11774.823377649513;12002.39988000614;12287.56993505223;10469.528871200662;10695.57217711314;10878.945605271923;10983.176261780558;11327.263727857662;9506.524673766145;10562;10598.25812193139;10695.090917272119;10729.785404292026 19:29:21 INFO - PROCESS | 8637 | __end_tp_report 19:29:21 INFO - PROCESS | 8637 | __start_cc_report 19:29:21 INFO - PROCESS | 8637 | _x_x_mozilla_cycle_collect,346 19:29:21 INFO - PROCESS | 8637 | __end_cc_report 19:29:21 INFO - PROCESS | 8637 | __startTimestamp1464834561598__endTimestamp 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | ------- Summary: start ------- 19:29:21 INFO - PROCESS | 8637 | Number of tests: 6 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#0] dojo.html Cycles:165 Average:5487.77 Median:5754.11 stddev:763.34 (13.3%) stddev-sans-first:742.73 19:29:21 INFO - PROCESS | 8637 | Values: 3119.6 3168.4 3181.5 3215.1 3216.5 5500.7 5523.8 5557.3 5635.6 5638.4 5375.4 5454.3 5498.7 5531.9 5534.8 5008.1 5023.0 5122.3 5126.6 5210.3 851.1 4893.6 4936.0 5072.2 5085.6 5008.8 5013.1 5047.6 5061.7 5067.7 5063.3 5074.9 5084.0 5084.4 5088.0 4914.6 4968.0 4975.8 5020.2 5062.4 5403.5 5436.8 5444.8 5461.6 5488.4 5767.7 5804.5 5919.0 6006.5 6011.8 5973.9 5988.2 6010.2 6061.5 6063.8 5602.1 5606.3 5614.4 5644.8 5648.9 5792.9 5841.7 6161.8 6177.5 6186.3 5710.3 5822.5 5910.1 5950.1 5992.1 5984.6 6041.4 6044.0 6057.3 6068.1 5779.8 5980.7 6051.3 6057.0 6061.9 5888.6 5946.1 5971.8 6010.2 6011.3 4291.6 4313.8 4316.9 4317.2 4359.3 3783.3 3805.9 3856.2 3896.6 3902.5 5533.3 5585.8 5613.0 5643.6 5647.4 5915.1 6001.6 6008.3 6012.6 6014.8 5698.1 5700.0 5704.1 5762.1 5786.3 4969.1 5003.0 5042.0 5042.1 5077.7 6000.5 6216.6 6253.7 6268.2 6268.9 5924.9 5970.3 5995.3 6042.5 6068.2 6180.6 6211.9 6219.9 6220.9 6236.5 5766.2 5837.6 5931.9 5936.1 5989.6 5892.6 5915.5 5934.5 5985.4 6016.7 5793.7 5824.0 5824.8 5829.6 5834.4 5660.5 5699.2 5720.0 5801.9 5809.0 5597.4 5636.9 5661.1 5669.2 5771.2 5802.5 5893.8 5909.4 5911.5 5922.3 5547.2 5726.7 5754.1 5754.5 5766.0 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#1] ext.html Cycles:180 Average:65258.44 Median:42656.97 stddev:135001.08 (316.5%) stddev-sans-first:135292.46 19:29:21 INFO - PROCESS | 8637 | Values: 582.4 629.4 646.3 646.7 648.1 42629.4 44011.1 44141.8 44282.6 47639.5 42420.2 42707.4 42748.0 42824.0 42882.1 8775.4 8930.6 8957.1 8968.9 9006.5 8817.4 8832.6 8951.2 8956.4 8990.6 8933.6 8947.6 8969.8 9019.8 9037.8 8899.0 8902.5 8969.6 8978.4 8983.3 8757.2 8918.3 8920.6 8927.8 8936.0 41000.0 41377.4 41610.2 41622.6 41636.0 3427.1 3617.1 3734.2 3786.2 3965.4 31297.7 31300.4 32007.2 32428.8 33025.5 4182.8 4210.8 4216.3 4218.0 4234.7 348599.0 349182.0 350760.0 351223.0 351592.0 57587.1 57868.0 57911.7 57936.4 57976.7 35855.0 36596.0 36662.8 38023.8 60691.7 16710.7 16712.9 16793.9 16820.4 16879.4 12488.1 12589.2 12596.9 12611.4 12676.9 19953.6 19959.2 19959.3 20027.0 20189.3 7131.6 7209.6 7370.6 7373.0 7394.4 985.4 1022.8 1054.6 1154.3 1180.7 32719.2 32811.3 32909.5 32933.0 33122.8 1088.6 1094.1 1172.6 1178.2 1183.3 16861.5 17101.0 17208.7 17260.2 17264.7 611421.0 616223.0 616297.0 617732.0 619341.0 57895.7 58559.4 58627.7 58822.7 58835.0 1336.4 1389.7 1394.8 1400.9 1403.9 31418.2 31972.7 32868.2 33002.8 34050.3 57922.7 58198.7 58798.7 58805.4 59038.0 515017.0 517111.0 517319.0 520782.0 521337.0 44611.0 44700.3 45853.0 46153.3 46261.8 48961.5 49941.3 49972.0 50688.0 50983.5 42321.2 42818.8 43242.4 43262.4 43846.0 42213.0 42347.6 43059.6 43522.3 43783.0 41396.6 42006.6 42365.0 42684.6 42933.0 36995.0 37470.5 38210.4 38565.2 38732.8 28962.9 28966.0 29023.5 29192.0 29306.4 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#2] jquery.html Cycles:180 Average:28916.26 Median:21207.07 stddev:83284.92 (392.7%) stddev-sans-first:83491.01 19:29:21 INFO - PROCESS | 8637 | Values: 391.9 394.9 395.2 401.2 411.6 13580.9 18391.1 18671.3 19364.6 19466.7 17504.6 17556.2 17837.6 18601.2 18635.5 5544.5 5607.7 5762.6 5777.1 5809.2 5628.7 5734.1 5752.1 5764.7 5780.9 5486.4 5671.9 5722.5 5739.7 5744.5 5682.6 5712.0 5712.5 5726.5 5730.1 4876.9 5090.7 5120.3 5122.1 5133.3 11970.9 12538.4 12643.8 22908.5 23041.7 2250.2 2268.3 2288.1 2293.1 2317.0 9446.0 9558.4 9944.7 9966.8 10070.3 1923.3 1953.8 1989.4 2008.8 2052.5 77272.6 80342.0 80485.0 81282.6 81712.6 10892.1 10931.0 10981.6 11135.4 11378.5 15467.3 15608.6 15623.7 15628.6 15670.0 7883.8 8041.0 8074.9 8229.4 8239.5 7663.9 7822.7 7890.6 7974.6 8010.8 4640.5 4670.4 4705.0 4800.8 4815.8 1914.9 1989.5 2000.2 2001.2 2052.7 904.9 989.6 1022.6 1034.2 1040.6 18485.6 19382.2 19537.6 19598.8 19649.3 969.2 989.7 1006.2 1018.2 1038.4 10597.5 10732.9 10789.5 10851.7 10938.7 496684.0 502678.0 506760.0 509490.0 513584.0 75180.0 83800.0 85878.6 93460.0 96352.0 888.3 900.6 910.4 915.7 969.8 16705.3 17070.8 17244.1 17333.5 17589.6 31622.8 42002.6 42439.4 42466.8 42843.0 57406.0 58059.4 59646.0 60030.0 60464.0 8138.6 8246.5 8410.8 8499.1 8650.5 11174.7 13069.5 13199.0 13323.5 13389.1 11242.4 11244.4 11520.5 11570.2 11590.7 10907.8 10909.2 10995.0 11183.8 11430.4 8513.6 11262.5 11394.1 11719.5 12078.0 8224.5 8335.7 8336.0 8419.8 8560.3 8683.9 10830.9 11272.8 12165.5 12176.1 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#3] mootools.html Cycles:180 Average:5975.99 Median:4555.69 stddev:3434.26 (75.4%) stddev-sans-first:3426.92 19:29:21 INFO - PROCESS | 8637 | Values: 1431.8 1480.8 1580.0 1706.2 1739.0 8110.5 8603.3 8768.7 9428.7 9468.3 9221.6 9285.4 9338.2 9343.4 9366.2 2371.2 2379.1 2405.2 2416.2 2417.7 2296.5 2341.6 2355.7 2357.3 2359.8 2284.0 2285.5 2303.6 2308.7 2322.3 2271.5 2275.5 2277.7 2299.1 2300.1 2293.9 2313.9 2317.6 2318.2 2333.3 9077.1 9154.3 9166.0 9227.2 9239.2 5084.6 5165.1 5193.0 5195.5 5206.9 3224.5 3324.5 3333.6 3368.5 3434.7 1146.7 1152.3 1989.8 2017.9 2058.3 12742.8 12818.1 12873.9 12889.9 12897.1 4370.7 4492.4 4544.5 4566.9 4572.0 10050.3 10051.6 10060.6 10075.6 10086.5 5100.9 5186.8 5187.4 5188.8 5203.3 4257.8 4658.9 4802.1 4866.7 4871.3 4115.7 4145.8 4169.7 4181.8 4183.6 1249.9 1256.8 1263.7 1273.9 1275.4 894.0 947.9 993.8 996.2 1013.1 5932.8 5938.0 6029.8 6051.2 6092.4 974.9 978.6 990.7 998.5 1022.5 3937.3 4151.8 4159.8 4186.1 4288.3 11224.0 11483.3 11525.4 11608.2 11627.1 10711.9 11412.6 11477.6 11519.9 11580.1 8316.6 8572.6 8613.7 8622.0 8652.7 5996.0 6123.3 6127.6 6212.9 6320.0 10259.8 10543.1 10589.4 10710.9 10791.5 10681.6 10698.9 10826.2 10831.2 10840.6 7370.0 7729.5 7734.3 7939.4 8062.3 8705.2 8923.6 8949.6 9001.5 9083.8 7828.3 7965.4 7977.1 7992.4 8053.1 7873.9 7929.5 8020.7 8084.5 8132.1 7198.7 7254.7 7280.5 7286.5 7324.3 5278.6 5295.5 5300.1 5324.4 5349.4 5291.6 5357.7 5389.1 5469.7 5472.1 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#4] prototype.html Cycles:180 Average:4876.68 Median:5487.23 stddev:1463.65 (26.7%) stddev-sans-first:1427.42 19:29:21 INFO - PROCESS | 8637 | Values: 330.2 341.3 346.6 349.5 352.9 5480.2 5615.2 5622.0 5692.8 5743.3 5548.2 5592.7 5617.6 5622.2 5643.5 4328.6 4329.2 4354.2 4386.2 4389.6 4137.8 4331.8 4358.8 4379.9 4389.8 4250.5 4275.0 4295.7 4302.4 4309.3 4334.2 4354.2 4355.6 4361.4 4378.0 3690.5 3754.3 3787.7 3844.0 3858.3 5315.9 5319.0 5322.5 5324.2 5326.6 4913.8 4929.1 4934.7 4959.7 4997.4 5534.9 5808.7 5865.0 5875.5 5888.3 4095.8 4109.6 4113.2 4123.3 4140.3 6082.2 6107.9 6141.9 6149.1 6157.5 4172.9 4276.9 4280.9 4283.2 4307.0 4333.2 4340.0 4357.3 4364.7 4386.6 4937.5 4944.7 4953.7 4956.2 4981.5 5738.5 5915.9 5929.9 5933.8 5981.3 1461.1 1465.7 1465.8 1491.2 1506.6 914.2 937.5 946.1 958.6 962.7 5054.4 5073.7 5075.3 5084.8 5162.6 5336.8 5362.2 5447.3 5463.6 5494.3 5014.6 5026.5 5040.3 5101.6 5146.2 2801.0 2854.5 2905.7 2914.5 2928.7 5531.4 5574.0 5575.9 5579.5 5629.9 5373.4 5725.6 6233.3 6240.4 6307.2 6334.0 6341.8 6343.3 6385.7 6396.3 5887.9 6108.1 6126.4 6171.2 6200.3 5998.6 6025.2 6028.9 6032.2 6088.0 6068.4 6295.3 6302.0 6364.0 6369.8 4176.4 4186.8 4195.0 4211.6 4216.8 6130.8 6179.8 6212.3 6225.5 6261.5 5808.9 5949.3 5976.9 6009.0 6096.4 5887.9 5944.5 5953.4 5966.0 5971.4 5621.6 5778.7 5787.1 5839.0 5844.2 5942.2 5948.7 5955.3 5960.0 5987.6 5819.7 5824.3 5832.4 5854.3 5862.5 19:29:21 INFO - PROCESS | 8637 | 19:29:21 INFO - PROCESS | 8637 | [#5] yui.html Cycles:180 Average:19735.90 Median:27035.58 stddev:27818.24 (102.9%) stddev-sans-first:27859.76 19:29:21 INFO - PROCESS | 8637 | Values: 752.2 758.5 776.7 832.8 856.8 15591.8 16359.3 16389.8 16917.2 17450.0 14993.4 15330.2 15333.5 15335.0 15361.2 819.0 823.1 823.9 824.2 825.8 693.6 795.8 812.1 812.3 816.8 855.1 857.4 858.1 858.4 862.7 846.8 850.1 857.6 858.2 860.3 626.3 628.2 629.6 630.0 632.1 15425.4 15432.9 15513.0 15514.5 15539.6 14577.0 14834.9 14934.3 14983.3 15217.6 12388.9 12408.9 12417.4 12536.7 12678.7 3884.5 3924.3 3931.6 3989.7 4015.7 72014.0 72737.3 72760.3 72898.0 72932.0 11405.5 11491.7 11568.9 11781.4 11942.2 19302.0 19450.8 19483.0 19519.3 19557.4 8987.6 9010.2 9036.9 9140.2 9164.8 4795.3 4798.7 4892.4 4950.7 5157.1 3515.1 3629.6 3630.6 3633.0 3634.4 624.8 631.0 641.6 647.5 649.6 576.9 665.6 691.9 702.4 772.3 9216.3 9528.9 9565.4 9586.8 9612.3 526.6 614.1 619.9 747.8 752.2 4056.5 4461.2 4473.3 4484.8 4592.3 66765.7 68006.3 83284.6 113528.0 114629.0 96341.5 97396.5 97705.5 99535.5 101121.5 69107.7 84495.0 85592.6 86511.0 89351.6 8409.5 8461.0 8594.7 8665.9 8672.9 49120.5 49588.3 49835.3 50731.7 51195.5 72421.0 76877.2 78237.6 78312.0 78884.6 11317.4 11632.2 11897.1 11966.9 12742.3 12694.8 12931.7 13321.4 13624.3 14284.0 11882.2 11969.4 12146.7 12186.9 12347.3 12669.7 12687.8 13254.7 13258.6 13267.7 11550.0 11732.2 11774.8 12002.4 12287.6 10469.5 10695.6 10878.9 10983.2 11327.3 9506.5 10562.0 10598.3 10695.1 10729.8 19:29:21 INFO - PROCESS | 8637 | -------- Summary: end -------- 19:29:21 INFO - PROCESS | 8637 | 19:29:22 INFO - TEST-INFO | 8637: exit 0 19:29:22 INFO - TEST-OK | dromaeo_css | took 1110077ms 19:29:22 INFO - TEST-START | kraken 19:29:22 INFO - operating with platform_type : linux_ 19:29:22 INFO - Initialising browser for kraken test... 19:29:22 INFO - TEST-INFO | started process 8874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrSg3W/profile http://localhost:40275/getInfo.html) 19:29:26 INFO - PROCESS | 8874 | __metrics Screen width/height:1600/1200 19:29:26 INFO - PROCESS | 8874 | colorDepth:24 19:29:26 INFO - PROCESS | 8874 | Browser inner width/height: 1024/697 19:29:26 INFO - PROCESS | 8874 | __metrics 19:29:26 ERROR - PROCESS | 8874 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:29:27 INFO - TEST-INFO | 8874: exit 0 19:29:27 INFO - Browser initialized. 19:29:27 INFO - Running cycle 1/1 for kraken test... 19:29:27 INFO - TEST-INFO | started process 8994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrSg3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:39 INFO - PROCESS | 8994 | RSS: Main: 167391232 19:29:39 INFO - PROCESS | 8994 | 19:29:41 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40275/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:42 INFO - PROCESS | 8994 | RSS: Main: 172630016 19:29:42 INFO - PROCESS | 8994 | 19:29:45 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40275/tests/kraken/driver.html?testName=audio-dft) 19:29:46 INFO - PROCESS | 8994 | RSS: Main: 171806720 19:29:46 INFO - PROCESS | 8994 | 19:29:49 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40275/tests/kraken/driver.html?testName=audio-fft) 19:29:49 INFO - PROCESS | 8994 | RSS: Main: 166871040 19:29:49 INFO - PROCESS | 8994 | 19:29:51 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40275/tests/kraken/driver.html?testName=audio-oscillator) 19:29:52 INFO - PROCESS | 8994 | RSS: Main: 167464960 19:29:52 INFO - PROCESS | 8994 | 19:29:54 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:55 INFO - PROCESS | 8994 | RSS: Main: 167854080 19:29:55 INFO - PROCESS | 8994 | 19:29:58 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40275/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:58 INFO - PROCESS | 8994 | RSS: Main: 168284160 19:29:58 INFO - PROCESS | 8994 | 19:30:02 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40275/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:03 INFO - PROCESS | 8994 | RSS: Main: 165765120 19:30:03 INFO - PROCESS | 8994 | 19:30:05 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40275/tests/kraken/driver.html?testName=json-parse-financial) 19:30:06 INFO - PROCESS | 8994 | RSS: Main: 166924288 19:30:06 INFO - PROCESS | 8994 | 19:30:08 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:08 INFO - PROCESS | 8994 | RSS: Main: 167526400 19:30:08 INFO - PROCESS | 8994 | 19:30:10 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:11 INFO - PROCESS | 8994 | RSS: Main: 168038400 19:30:11 INFO - PROCESS | 8994 | 19:30:13 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:13 INFO - PROCESS | 8994 | RSS: Main: 168144896 19:30:13 INFO - PROCESS | 8994 | 19:30:16 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:17 INFO - PROCESS | 8994 | RSS: Main: 168415232 19:30:17 INFO - PROCESS | 8994 | 19:30:19 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:20 INFO - PROCESS | 8994 | RSS: Main: 168271872 19:30:20 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | Cycle 1(1): loaded http://localhost:40275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40275/tests/kraken/driver.html?testName=ai-astar) 19:30:22 INFO - PROCESS | 8994 | RSS: Main: 168841216 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | __start_tp_report 19:30:22 INFO - PROCESS | 8994 | _x_x_mozilla_page_load 19:30:22 INFO - PROCESS | 8994 | _x_x_mozilla_page_load_details 19:30:22 INFO - PROCESS | 8994 | |i|pagename|runs| 19:30:22 INFO - PROCESS | 8994 | |0;ai-astar;113;109;111;112;112;114;112;112;112;112 19:30:22 INFO - PROCESS | 8994 | |1;audio-beat-detection;163;141;151;185;142;151;162;128;188;128 19:30:22 INFO - PROCESS | 8994 | |2;audio-dft;163;163;163;163;167;175;163;166;162;164 19:30:22 INFO - PROCESS | 8994 | |3;audio-fft;76;75;76;156;75;77;77;75;156;76 19:30:22 INFO - PROCESS | 8994 | |4;audio-oscillator;85;84;156;84;85;84;150;85;84;147 19:30:22 INFO - PROCESS | 8994 | |5;imaging-gaussian-blur;118;117;120;119;118;118;118;117;118;117 19:30:22 INFO - PROCESS | 8994 | |6;imaging-darkroom;148;148;148;148;150;147;149;148;148;147 19:30:22 INFO - PROCESS | 8994 | |7;imaging-desaturate;95;95;96;96;96;95;96;97;96;97 19:30:22 INFO - PROCESS | 8994 | |8;json-parse-financial;54;53;55;53;61;54;53;54;54;54 19:30:22 INFO - PROCESS | 8994 | |9;json-stringify-tinderbox;62;63;62;62;64;63;62;68;63;62 19:30:22 INFO - PROCESS | 8994 | |10;stanford-crypto-aes;85;83;80;80;80;83;83;83;105;81 19:30:22 INFO - PROCESS | 8994 | |11;stanford-crypto-ccm;130;133;120;123;130;123;134;136;126;126 19:30:22 INFO - PROCESS | 8994 | |12;stanford-crypto-pbkdf2;172;160;160;165;160;169;160;163;160;163 19:30:22 INFO - PROCESS | 8994 | |13;stanford-crypto-sha256-iterative;63;63;64;63;65;65;66;64;63;66 19:30:22 INFO - PROCESS | 8994 | __end_tp_report 19:30:22 INFO - PROCESS | 8994 | __start_cc_report 19:30:22 INFO - PROCESS | 8994 | _x_x_mozilla_cycle_collect,888 19:30:22 INFO - PROCESS | 8994 | __end_cc_report 19:30:22 INFO - PROCESS | 8994 | __startTimestamp1464834622307__endTimestamp 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | ------- Summary: start ------- 19:30:22 INFO - PROCESS | 8994 | Number of tests: 14 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.29 (1.1%) stddev-sans-first:1.30 19:30:22 INFO - PROCESS | 8994 | Values: 113.0 109.0 111.0 112.0 112.0 114.0 112.0 112.0 112.0 112.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:156.50 stddev:20.94 (13.4%) stddev-sans-first:21.95 19:30:22 INFO - PROCESS | 8994 | Values: 163.0 141.0 151.0 185.0 142.0 151.0 162.0 128.0 188.0 128.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.50 stddev:3.87 (2.4%) stddev-sans-first:4.04 19:30:22 INFO - PROCESS | 8994 | Values: 163.0 163.0 163.0 163.0 167.0 175.0 163.0 166.0 162.0 164.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#3] audio-fft Cycles:10 Average:91.90 Median:76.00 stddev:33.79 (44.5%) stddev-sans-first:35.35 19:30:22 INFO - PROCESS | 8994 | Values: 76.0 75.0 76.0 156.0 75.0 77.0 77.0 75.0 156.0 76.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:84.00 stddev:32.23 (38.4%) stddev-sans-first:33.41 19:30:22 INFO - PROCESS | 8994 | Values: 85.0 84.0 156.0 84.0 85.0 84.0 150.0 85.0 84.0 147.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 19:30:22 INFO - PROCESS | 8994 | Values: 118.0 117.0 120.0 119.0 118.0 118.0 118.0 117.0 118.0 117.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 19:30:22 INFO - PROCESS | 8994 | Values: 148.0 148.0 148.0 148.0 150.0 147.0 149.0 148.0 148.0 147.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 19:30:22 INFO - PROCESS | 8994 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 97.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.37 (4.4%) stddev-sans-first:2.51 19:30:22 INFO - PROCESS | 8994 | Values: 54.0 53.0 55.0 53.0 61.0 54.0 53.0 54.0 54.0 54.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:1.85 (2.9%) stddev-sans-first:1.92 19:30:22 INFO - PROCESS | 8994 | Values: 62.0 63.0 62.0 62.0 64.0 63.0 62.0 68.0 63.0 62.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:7.47 (9.0%) stddev-sans-first:7.92 19:30:22 INFO - PROCESS | 8994 | Values: 85.0 83.0 80.0 80.0 80.0 83.0 83.0 83.0 105.0 81.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:130.00 stddev:5.32 (4.1%) stddev-sans-first:5.60 19:30:22 INFO - PROCESS | 8994 | Values: 130.0 133.0 120.0 123.0 130.0 123.0 134.0 136.0 126.0 126.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:4.29 (2.6%) stddev-sans-first:3.15 19:30:22 INFO - PROCESS | 8994 | Values: 172.0 160.0 160.0 165.0 160.0 169.0 160.0 163.0 160.0 163.0 19:30:22 INFO - PROCESS | 8994 | 19:30:22 INFO - PROCESS | 8994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.23 (1.9%) stddev-sans-first:1.22 19:30:22 INFO - PROCESS | 8994 | Values: 63.0 63.0 64.0 63.0 65.0 65.0 66.0 64.0 63.0 66.0 19:30:22 INFO - PROCESS | 8994 | -------- Summary: end -------- 19:30:22 INFO - PROCESS | 8994 | 19:30:23 INFO - TEST-INFO | 8994: exit 0 19:30:23 INFO - TEST-OK | kraken | took 60933ms 19:30:23 INFO - SUITE-END | took 1171s 19:30:23 INFO - Completed test suite (00:19:31) 19:30:23 INFO - javascript benchmark 19:30:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.398802717331, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.62564492261, 3168.3980043791694, 3181.5068664357027, 3215.099772063823, 3216.5175223716456, 5500.724963751812, 5523.806666766664, 5557.333120025598, 5635.63368381055, 5638.40796716345, 5375.43557926418, 5454.34547854257, 5498.725063746817, 5531.944680553193, 5534.806281780138, 5008.098542262401, 5022.974885125569, 5122.3084883540805, 5126.5642420394315, 5210.348706411699, 851.0760545981444, 4893.632977526682, 4935.950640493603, 5072.213806859942, 5085.567726743213, 5008.7996480140755, 5013.097642424362, 5047.570956468705, 5061.721605311706, 5067.74661266937, 5063.316452278932, 5074.873128171788, 5084.0, 5084.415292241366, 5087.974560127176, 4914.606831453475, 4968.0, 4975.776090075955, 5020.2218656108, 5062.392512898439, 5403.486668766461, 5436.836894893159, 5444.8366549003595, 5461.590380721462, 5488.4237155098535, 5767.682777447239, 5804.506616937565, 5918.970405147989, 6006.489448396892, 6011.849703757397, 5973.880522389528, 5988.19159413478, 6010.2186715726675, 6061.454469097803, 6063.848403789941, 5602.131669591261, 5606.299212598426, 5614.410486898899, 5644.802431914904, 5648.943510564883, 5792.88414231713, 5841.7371218295275, 6161.7535298588455, 6177.536684748572, 6186.257649082049, 5710.3433105193435, 5822.475977162076, 5910.054391297458, 5950.107483877453, 5992.0712289595185, 5984.640921544721, 6041.365656606081, 6044.03295472731, 6057.303410107894, 6068.059450785136, 5779.768809247667, 5980.73086711099, 6051.334353221142, 6057.030875059969, 6061.878762424727, 5888.61723987948, 5946.137810017523, 5971.7611295547695, 6010.158577799111, 6011.3086994995265, 4291.6137547620865, 4313.827446902152, 4316.892077698083, 4317.201317756225, 4359.2807186813825, 3783.3000894834545, 3805.904852378713, 3856.2287542491613, 3896.59085795993, 3902.5316961964745, 5533.3083364579425, 5585.832425027255, 5612.961602103624, 5643.5767317451355, 5647.407022262603, 5915.053591425351, 6001.639901605918, 6008.279006519158, 6012.609180403259, 6014.8195554133445, 5698.059820129715, 5699.971500142473, 5704.1443783432815, 5762.1068734346245, 5786.334571524329, 4969.055879382906, 5003.049420610072, 5042.042012017705, 5042.117629414838, 5077.720725360141, 6000.519958403404, 6216.564840461215, 6253.6560489173535, 6268.153799237136, 6268.874622507525, 5924.881502369843, 5970.253718285127, 5995.310539288038, 6042.486388656837, 6068.241469816273, 6180.567360284737, 6211.9068213977735, 6219.875602487835, 6220.875582488235, 6236.501079913505, 5766.163906233656, 5837.562182836219, 5931.851703707442, 5936.079907614154, 5989.580729348903, 5892.558058145742, 5915.526757859275, 5934.495567876779, 5985.40145985398, 6016.699165041818, 5793.652380857162, 5824.039033559585, 5824.825255242349, 5829.562782791223, 5834.38738932406, 5660.462256085665, 5699.173619825185, 5719.971400142973, 5801.883962320646, 5808.970955145197, 5597.412271711411, 5636.85907852307, 5661.122526008476, 5669.206311116364, 5771.2208851806145, 5802.50678692299, 5893.764249430146, 5909.409059094056, 5911.467967882912, 5922.289325280994, 5547.195656629686, 5726.713664316851, 5754.108113242454, 5754.53963682896, 5765.971170144123], "value": 5434.175991773166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4030368871905, 629.433509841143, 646.2632598837323, 646.689588997281, 648.1315037849284, 42629.36055959163, 44011.11977760443, 44141.77929110354, 44282.557174428286, 47639.52360476394, 42420.15159696804, 42707.359389609104, 42748.0, 42824.0, 42882.142357152916, 8775.429597076201, 8930.642774289021, 8957.149070838292, 8968.910310896905, 9006.504642244674, 8817.426867253607, 8832.602532886003, 8951.194392504673, 8956.373053886231, 8990.59542320594, 8933.59798809052, 8947.552622368888, 8969.775755606097, 9019.819603607924, 9037.819243615124, 8899.0, 8902.510361930092, 8969.596368163384, 8978.416402933788, 8983.326250531203, 8757.211850933383, 8918.331125165638, 8920.553972301424, 8927.776805579848, 8936.0, 41000.0, 41377.37933930993, 41610.1677966442, 41622.58377416217, 41636.0, 3427.074689833731, 3617.149969757105, 3734.178480734234, 3786.1859700164596, 3965.4250133730734, 31297.687023129933, 31300.37399252002, 32007.199820004687, 32428.837855810805, 33025.50461743076, 4182.811773470201, 4210.768407737573, 4216.3464662977285, 4218.0, 4234.724742891703, 348599.0, 349182.0, 350760.0, 351223.0, 351592.0, 57587.136192957136, 57868.0, 57911.71044144837, 57936.42063579395, 57976.71011644915, 35855.0, 36596.0, 36662.8166859164, 38023.80988095097, 60691.69654151789, 16710.66578668444, 16712.916435417745, 16793.91603041977, 16820.411285604947, 16879.40922067722, 12488.12583119173, 12589.24464532131, 12596.937015314865, 12611.432485538173, 12676.873231267753, 19953.60092798136, 19959.20163193485, 19959.301424450074, 20027.0, 20189.293374732108, 7131.607761573163, 7209.639518024078, 7370.557766534025, 7373.0, 7394.371478424287, 985.4038306824411, 1022.8158931392272, 1054.620336678795, 1154.3362566524281, 1180.734334774686, 32719.199119868048, 32811.343773124405, 32909.50635740466, 32933.0, 33122.8343858284, 1088.5700148441479, 1094.0919037199105, 1172.5753209850072, 1178.1693905796392, 1183.2722875431548, 16861.494155175365, 17101.0, 17208.741868871726, 17260.223289951984, 17264.654706905792, 611421.0, 616223.0, 616297.0, 617732.0, 619341.0, 57895.71052144712, 58559.414405856245, 58627.70686146542, 58822.70588647029, 58835.0, 1336.385262779113, 1389.6803735140975, 1394.7698629726185, 1400.9369578368999, 1403.9087459315112, 31418.21454463657, 31972.68027319697, 32868.178295542806, 33002.83498582492, 34050.31899362049, 57922.7103864478, 58198.709006454694, 58798.70600646969, 58805.41194587999, 59038.0, 515017.0, 517111.0, 517319.0, 520782.0, 521337.0, 44611.0, 44700.32949505825, 45853.0, 46153.30770038385, 46261.768691157675, 48961.51038489569, 49941.25088123754, 49972.0, 50688.0, 50983.49016509787, 42321.153576928904, 42818.78590607027, 43242.35136472892, 43262.351064734685, 43846.0, 42213.0, 42347.57652423436, 43059.569404305556, 43522.34716479192, 43783.0, 41396.586034139276, 42006.579934200265, 42365.0, 42684.57315426806, 42933.0, 36995.0, 37470.503539575424, 38210.42684359681, 38565.22869542649, 38732.80633596814, 28962.855185723936, 28966.0, 29023.541105778073, 29192.0, 29306.41387172202], "value": 20732.893001427576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9333713268743, 394.9368101103824, 395.2076087444675, 401.17358242021436, 411.5678537535589, 13580.932095339534, 18391.080445977714, 18671.346502872402, 19364.612707745855, 19466.707999380003, 17504.64990700185, 17556.209970551325, 17837.64324713505, 18601.162947667355, 18635.534111647215, 5544.500994910457, 5607.663540187592, 5762.56780741444, 5777.133429985493, 5809.186713860063, 5628.746706398222, 5734.139879018139, 5752.1084231943905, 5764.74058667361, 5780.884382312352, 5486.423925487826, 5671.8582035449235, 5722.456366645162, 5739.655620662753, 5744.4829965303115, 5682.630629009122, 5711.971440142773, 5712.514436272922, 5726.455986681259, 5730.140478928173, 4876.926846097312, 5090.720010399426, 5120.283160357553, 5122.129238029506, 5133.281340612317, 11970.940145299217, 12538.373081345897, 12643.810342844772, 22908.54182916349, 23041.654375184386, 2250.234920127148, 2268.319504148749, 2288.084766093559, 2293.0942277800177, 2317.015268510893, 9446.00816914221, 9558.426494410358, 9944.651937182163, 9966.750831229205, 10070.345427547187, 1923.2691577200715, 1953.7655481342188, 1989.4429559723155, 2008.7890771469079, 2052.5073982244303, 77272.61363693202, 80342.0, 80485.0, 81282.59358703169, 81712.59143704243, 10892.128629709605, 10931.01620854111, 10981.560737570568, 11135.387553684624, 11378.54485820558, 15467.303971321318, 15608.609784755472, 15623.687526249412, 15628.609284767972, 15670.0, 7883.763487095396, 8041.0, 8074.919250807534, 8229.382796290301, 8239.464434811838, 7663.885041724378, 7822.687092516236, 7890.64492097857, 7974.5613991229875, 8010.79973000668, 4640.466346370143, 4670.392848929685, 4705.0, 4800.783964721596, 4815.807367705323, 1914.9329773457862, 1989.4727897107277, 2000.1988269211477, 2001.1595130045416, 2052.6818343156833, 904.9457032578066, 989.5645915797027, 1022.5654097008742, 1034.1623285139062, 1040.635777477892, 18485.630287394444, 19382.224711011684, 19537.609247814966, 19598.804011959983, 19649.31227407034, 969.1616751510035, 989.7426669065951, 1006.2402885821305, 1018.1803648063232, 1038.444432228754, 10597.470126493645, 10732.94633526843, 10789.46052697362, 10851.67444976652, 10938.671839844817, 496684.0, 502678.0, 506760.0, 509490.0, 513584.0, 75180.0, 83800.0, 85878.57060714782, 93460.0, 96352.0, 888.2716172738293, 900.6127365233012, 910.3991365698607, 915.7435917942987, 969.8205831921117, 16705.331786728395, 17070.82929170742, 17244.137793110043, 17333.47999560015, 17589.560260993578, 31622.841885790425, 42002.579974201086, 42439.3634095495, 42466.78766606147, 42843.0, 57406.0, 58059.4194058054, 59646.0, 60030.0, 60464.0, 8138.633761480866, 8246.463979841292, 8410.789730256793, 8499.065102838806, 8650.480971141751, 11174.66476005721, 13069.542566010525, 13199.0, 13323.533676321282, 13389.062765606313, 11242.437878105899, 11244.381559014333, 11520.481578328827, 11570.247933884271, 11590.652280431601, 10907.781844363228, 10909.236353455182, 10995.0, 11183.832242516206, 11430.428478576205, 8513.616887239965, 11262.549498019987, 11394.08847292198, 11719.531218751154, 12078.0, 8224.506529608243, 8335.666573337241, 8336.0, 8419.789505262417, 8560.272376847788, 8683.86974195375, 10830.945845270724, 11272.83090753623, 12165.452554634885, 12176.147669663038], "value": 8974.59206951663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.799548063271, 1480.8000919875817, 1579.9921000394995, 1706.2407228783181, 1738.9829493869163, 8110.472819266758, 8603.311735061196, 8768.69309574165, 9428.717138485848, 9468.289878259124, 9221.58502867371, 9285.442873427599, 9338.159565639091, 9343.39267947583, 9366.20387267083, 2371.1937941100064, 2379.1435083369975, 2405.230326295586, 2416.226807421626, 2417.697787776528, 2296.5062511560013, 2341.625339945609, 2355.6702061711376, 2357.281029286067, 2359.8466099703464, 2284.0407029047756, 2285.5086156476355, 2303.55080759252, 2308.722953245613, 2322.3033090072995, 2271.4548508357957, 2275.5335156293004, 2277.7152855893014, 2299.149314753552, 2300.068472268734, 2293.908243670251, 2313.90744370225, 2317.5944209763225, 2318.1654604342425, 2333.288347054148, 9077.092290770936, 9154.267658587298, 9165.954170229174, 9227.215686666641, 9239.168474837297, 5084.567811736007, 5165.147750621143, 5192.974035129838, 5195.480451954812, 5206.895862082775, 3224.4840825467813, 3324.4514655081884, 3333.6499667534804, 3368.461046232591, 3434.708049815769, 1146.6789298996212, 1152.3489228585822, 1989.7811240763504, 2017.9495512612154, 2058.289889987952, 12742.80885786714, 12818.102732808615, 12873.871261287455, 12889.871101288962, 12897.09720319578, 4370.650347972218, 4492.438445194351, 4544.500104988449, 4566.885827854264, 4571.954280457153, 10050.296479246528, 10051.648192313234, 10060.647877324258, 10075.596976120873, 10086.49567521621, 5100.948990510122, 5186.818461353834, 5187.403448603383, 5188.766505507261, 5203.271541984125, 4257.765822879709, 4658.930116048262, 4802.111609352281, 4866.7079975201605, 4871.269309603517, 4115.691323150776, 4145.79271036447, 4169.731427549063, 4181.811818468115, 4183.6234738873645, 1249.8688686738517, 1256.824044633752, 1263.684078980255, 1273.9108262421728, 1275.3623188405797, 893.9553022348856, 947.8530827721714, 993.7565296502403, 996.1532697207316, 1013.0578561937322, 5932.762689492372, 5937.970310148422, 6029.849253768691, 6051.213342265477, 6092.390760923872, 974.8878878928872, 978.5889926231, 990.7374545745383, 998.5157198758596, 1022.5091955861228, 3937.291287568265, 4151.813168407429, 4159.812808423628, 4186.099988502426, 4288.270993931039, 11224.0, 11483.25358851672, 11525.423728813526, 11608.187426880037, 11627.069834413227, 10711.892881071246, 11412.600558980395, 11477.598284060017, 11519.942400287944, 11580.073594112451, 8316.584170791557, 8572.614232359434, 8613.741587752378, 8622.0, 8652.69715559965, 5996.0, 6123.295820980644, 6127.571070025234, 6212.875742485035, 6320.0, 10259.846102308322, 10543.103836174012, 10589.417582033062, 10710.946445267724, 10791.514381852992, 10681.57273709043, 10698.89301106979, 10826.188035897496, 10831.187660925305, 10840.620578279722, 7370.0, 7729.497582657109, 7734.33711751976, 7939.364850812037, 8062.274395304451, 8705.173008564176, 8923.598438070172, 8949.642014319354, 9001.504917229615, 9083.818323633623, 7828.256315650005, 7965.392905744257, 7977.08263549676, 7992.36061115121, 8053.073896501977, 7873.921260787319, 7929.5242285463055, 8020.679172833022, 8084.514929104273, 8132.146124656826, 7198.676059577437, 7254.746083887038, 7280.526765760209, 7286.489945703962, 7324.267573242846, 5278.551323137576, 5295.549878260391, 5300.098983172793, 5324.414314425333, 5349.438308977501, 5291.603129765206, 5357.651752636066, 5389.083855744611, 5469.726513674221, 5472.097103977958], "value": 4788.030734049877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.20053522056895, 341.3105526835792, 346.5598689664126, 349.50195970741703, 352.917064489845, 5480.177973304007, 5615.185798059279, 5622.0, 5692.829215123547, 5743.253377060982, 5548.223248745179, 5592.720363981794, 5617.578681598886, 5622.240997465341, 5643.548516118711, 4328.63206627437, 4329.1558146161515, 4354.238008348534, 4386.232409328355, 4389.6049355558, 4137.81379837908, 4331.8483853065145, 4358.825646974133, 4379.912401751963, 4389.824407023715, 4250.48994120706, 4275.0, 4295.72077814941, 4302.354646802974, 4309.31051031835, 4334.198173337927, 4354.2162410765895, 4355.586219309161, 4361.43301370823, 4377.956220437787, 3690.4833323334756, 3754.2866855297407, 3787.715921305913, 3843.9621302248515, 3858.2862170498265, 5315.867103322409, 5319.0, 5322.467753224685, 5324.201369794562, 5326.600504962104, 4913.803447862081, 4929.137400954819, 4934.654574179809, 4959.677620954626, 4997.42529609096, 5534.944650553483, 5808.7095645218, 5865.0, 5875.500582450454, 5888.322842873039, 4095.8361665533344, 4109.630133287988, 4113.1568028554375, 4123.340265557526, 4140.275451795924, 6082.1789058477425, 6107.862248213134, 6141.938580614226, 6149.108379284979, 6157.507399408037, 4172.937405938914, 4276.893077673083, 4280.892977675583, 4283.2290187765875, 4306.978465107654, 4333.241682705514, 4339.978300108479, 4357.324614684729, 4364.672649551233, 4386.649068074546, 4937.481564435682, 4944.678595891256, 4953.687272872619, 4956.231784073474, 4981.476944920803, 5738.540916726652, 5915.940840591625, 5929.911051334234, 5933.842900634421, 5981.252343457068, 1461.101422625099, 1465.6735654232937, 1465.827338129492, 1491.2320155120121, 1506.5856889355514, 914.2229105260475, 937.4515908193647, 946.1437399153776, 958.5782255807422, 962.6775030364767, 5054.368203974504, 5073.670211436245, 5075.289459475676, 5084.8220312288895, 5162.638615296968, 5336.759845806948, 5362.249285100089, 5447.319085114361, 5463.644863083887, 5494.2857428534035, 5014.606608503461, 5026.52248036436, 5040.269160971712, 5101.617378696613, 5146.228065790161, 2800.957985630217, 2854.4728570214834, 2905.7239562241552, 2914.533674612052, 2928.677845437, 5531.419200983919, 5574.0, 5575.860603484864, 5579.4978451938705, 5629.859253518613, 5373.435789242073, 5725.59920805548, 6233.283172435228, 6240.438360547572, 6307.180066591313, 6334.0, 6341.778037768656, 6343.270523889812, 6385.744570217139, 6396.264429590564, 5887.910736513759, 6108.144859719731, 6126.417990290915, 6171.197744293213, 6200.3489633589625, 5998.640081595118, 6025.246844144482, 6028.939710602838, 6032.155498230339, 6087.969560152171, 6068.393160683896, 6295.338989406229, 6302.0, 6364.0, 6369.77705780314, 4176.43618111551, 4186.790660466903, 4194.951262184454, 4211.578842115887, 4216.7680777557525, 6130.816075517741, 6179.81460556184, 6212.316645169119, 6225.501959843292, 6261.467775238973, 5808.937827071329, 5949.286085669747, 5976.940230597638, 6009.038553831366, 6096.41493211777, 5887.852803679771, 5944.524438045032, 5953.374895635896, 5965.985782416913, 5971.447423669791, 5621.634593751393, 5778.74628894723, 5787.102999035156, 5838.970805145947, 5844.240248767633, 5942.1978032965, 5948.702564871653, 5955.315138758925, 5959.970200149145, 5987.64074155552, 5819.679917604572, 5824.301083869963, 5832.445917637818, 5854.297484301911, 5862.530997520274], "value": 4407.124182806256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2214507984237, 758.4501236603463, 776.6582703610408, 832.8417600655874, 856.790086428825, 15591.84408155918, 16359.263833127508, 16389.83610163898, 16917.154142292897, 17450.0, 14993.400263989428, 15330.233488325595, 15333.463328783495, 15335.0, 15361.15513646749, 818.9590520473982, 823.069930977994, 823.8887750153742, 824.1552408780988, 825.8059356051323, 693.6046453521495, 795.757294025325, 812.0580127052621, 812.297362781196, 816.7672213419177, 855.0722466124263, 857.4426622695266, 858.107568129145, 858.3519442820661, 862.7454900804278, 846.7713717296295, 850.1371108325055, 857.5540718826206, 858.1590041759049, 860.2687715441856, 626.3266987987931, 628.1927722876128, 629.6442509981846, 630.014028046111, 632.1276638239246, 15425.382984680711, 15432.922835385863, 15513.0, 15514.5345639631, 15539.611509712235, 14576.979611427205, 14834.851651483455, 14934.25328733559, 14983.32575034126, 15217.61955951099, 12388.876111238862, 12408.875911240862, 12417.44121514534, 12536.74926501474, 12678.746425071447, 3884.4561761353434, 3924.3328634132267, 3931.5871833457645, 3989.6608788252743, 4015.738976966517, 72014.0, 72737.27262727411, 72760.27239727588, 72898.0, 72932.0, 11405.486753096131, 11491.71270718222, 11568.911296360904, 11781.352025638673, 11942.16404851652, 19302.0, 19450.8054919449, 19483.0, 19519.31682391138, 19557.413277601696, 8987.640494380283, 9010.234130099016, 9036.909630903738, 9140.177384035469, 9164.816703665889, 4795.2505702702265, 4798.66409351349, 4892.412910450768, 4950.653454258168, 5157.123289040872, 3515.086077619786, 3629.6207441172714, 3630.5824830144343, 3633.0190848470766, 3634.4184930411006, 624.8094331229019, 631.0313668518802, 641.6374748267308, 647.5402464250341, 649.5842660697158, 576.8529025098657, 665.6405541007898, 691.9031335613018, 702.4310308650009, 772.2972095393166, 9216.262698984065, 9528.90471095294, 9565.378250413702, 9586.771926159223, 9612.327137100336, 526.5708447615182, 614.0972770028052, 619.8946179149556, 747.816784887706, 752.1801236652076, 4056.492938382702, 4461.152381047591, 4473.329000649928, 4484.820607175741, 4592.334111553806, 66765.6661716698, 68006.31993679999, 83284.58357708172, 113528.0, 114629.0, 96341.51829240809, 97396.51301743445, 97705.51147244219, 99535.50232248937, 101121.49439252904, 69107.65446172738, 84495.0, 85592.57203714066, 86511.0, 89351.55324223338, 8409.453385529921, 8461.0, 8594.742157735278, 8665.870011949699, 8672.913270867211, 49120.50879491159, 49588.25617615811, 49835.25247121223, 50731.746341269536, 51195.48804511907, 72421.0, 76877.231227687, 78237.60881195558, 78312.0, 78884.60557697175, 11317.434128293387, 11632.243904146204, 11897.122179906197, 11966.880331196577, 12742.299173545543, 12694.809577856155, 12931.741365172831, 13321.441561741774, 13624.250666213056, 14284.0, 11882.16824822254, 11969.401529923643, 12146.696332591757, 12186.878131218575, 12347.320897350732, 12669.683257918627, 12687.80968285495, 13254.734905302033, 13258.602241932758, 13267.734645306848, 11550.0, 11732.178747487595, 11774.823377649513, 12002.39988000614, 12287.56993505223, 10469.528871200662, 10695.57217711314, 10878.945605271923, 10983.176261780558, 11327.263727857662, 9506.524673766145, 10562.0, 10598.25812193139, 10695.090917272119, 10729.785404292026], "value": 7378.923678377216, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 111.0, 112.0, 112.0, 114.0, 112.0, 112.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 141.0, 151.0, 185.0, 142.0, 151.0, 162.0, 128.0, 188.0, 128.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 167.0, 175.0, 163.0, 166.0, 162.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 156.0, 75.0, 77.0, 77.0, 75.0, 156.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 156.0, 84.0, 85.0, 84.0, 150.0, 85.0, 84.0, 147.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 120.0, 119.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 150.0, 147.0, 149.0, 148.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 53.0, 61.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 64.0, 63.0, 62.0, 68.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 80.0, 80.0, 80.0, 83.0, 83.0, 83.0, 105.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 120.0, 123.0, 130.0, 123.0, 134.0, 136.0, 126.0, 126.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 160.0, 160.0, 165.0, 160.0, 169.0, 160.0, 163.0, 160.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 65.0, 66.0, 64.0, 63.0, 66.0], "value": 64.2, "unit": "score"}]}]} 19:30:23 INFO - Return code: 0 19:30:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:30:23 ERROR - # TBPL SUCCESS # 19:30:23 INFO - Running post-action listener: _resource_record_post_action 19:30:23 INFO - ##### 19:30:23 INFO - ##### Finished run-tests step (success) 19:30:23 INFO - ##### 19:30:23 INFO - Running post-run listener: _resource_record_post_run 19:30:23 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 538005504; Read time: 0; Write time: 497656 19:30:23 INFO - TinderboxPrint: CPU usage
13.5% 19:30:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:30:23 INFO - TinderboxPrint: I/O write bytes / time
538,005,504 / 497,656 19:30:23 INFO - TinderboxPrint: CPU idle
8,205.9 (86.5%) 19:30:23 INFO - TinderboxPrint: CPU user
1,227.8 (12.9%) 19:30:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:30:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247615488; Read time: 0; Write time: 253268 19:30:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 288055296; Read time: 0; Write time: 244196 19:30:24 INFO - Running post-run listener: _upload_blobber_files 19:30:24 INFO - Blob upload gear active. 19:30:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:24 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:30:24 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:30:24 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:30:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:25 INFO - (blobuploader) - INFO - Done attempting. 19:30:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:29 INFO - (blobuploader) - INFO - Done attempting. 19:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:31 INFO - (blobuploader) - INFO - Done attempting. 19:30:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:31 INFO - Return code: 0 19:30:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3db7fc40f8a59ddc88f3cb5ce29653d419ba923bc7d9238480cbc50510f7e0ea450ba7fb137d8560e543e3c409fb38b5d7133d0d9895caf780b34b6fbb72dd43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d1ce42a9385fa76e4b488a61d1acc613959698b936412f3a459803237c5b59318a1b658c64e31cee7d0d147905d9cd568671fc6ec21f1083a1444c2070ef7ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ead85c28e22236182895f628400a5d7715b8a59587254355bf386795ff6c608ff21ab180814c934e31e18fdcee39326d4ad99f3e51562b6e029d6b49b6fb86e"} 19:30:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:31 INFO - Contents: 19:30:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3db7fc40f8a59ddc88f3cb5ce29653d419ba923bc7d9238480cbc50510f7e0ea450ba7fb137d8560e543e3c409fb38b5d7133d0d9895caf780b34b6fbb72dd43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d1ce42a9385fa76e4b488a61d1acc613959698b936412f3a459803237c5b59318a1b658c64e31cee7d0d147905d9cd568671fc6ec21f1083a1444c2070ef7ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ead85c28e22236182895f628400a5d7715b8a59587254355bf386795ff6c608ff21ab180814c934e31e18fdcee39326d4ad99f3e51562b6e029d6b49b6fb86e"} 19:30:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:31 INFO - Copying logs to upload dir... 19:30:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.296312 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-01 19:30:30.516018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:30:30.522236) ========= 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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 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/3db7fc40f8a59ddc88f3cb5ce29653d419ba923bc7d9238480cbc50510f7e0ea450ba7fb137d8560e543e3c409fb38b5d7133d0d9895caf780b34b6fbb72dd43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d1ce42a9385fa76e4b488a61d1acc613959698b936412f3a459803237c5b59318a1b658c64e31cee7d0d147905d9cd568671fc6ec21f1083a1444c2070ef7ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ead85c28e22236182895f628400a5d7715b8a59587254355bf386795ff6c608ff21ab180814c934e31e18fdcee39326d4ad99f3e51562b6e029d6b49b6fb86e"} 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.011303 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/3db7fc40f8a59ddc88f3cb5ce29653d419ba923bc7d9238480cbc50510f7e0ea450ba7fb137d8560e543e3c409fb38b5d7133d0d9895caf780b34b6fbb72dd43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d1ce42a9385fa76e4b488a61d1acc613959698b936412f3a459803237c5b59318a1b658c64e31cee7d0d147905d9cd568671fc6ec21f1083a1444c2070ef7ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ead85c28e22236182895f628400a5d7715b8a59587254355bf386795ff6c608ff21ab180814c934e31e18fdcee39326d4ad99f3e51562b6e029d6b49b6fb86e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:30:30.548226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:30:30.548616) ========= 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=923d835db2ba3686ebe126b700000192-1464825524.726497-293408401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:30:30.631894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:30:30.632264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:30:30.632571) ========= ========= Total master_lag: 0.16 =========