builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0305 starttime: 1463487134.63 results: success (0) buildid: 20160517030211 builduid: 4782507b8501407684e187013b538914 revision: a884b96685aa13b65601feddb24e5f85ba861561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.627864) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.628306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.628594) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.674590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.674874) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-17 05:12:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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-05-17 05:12:14 (223 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.853664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.853986) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025752 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.919980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:14.920367) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a884b96685aa13b65601feddb24e5f85ba861561 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a884b96685aa13b65601feddb24e5f85ba861561 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-17 05:12:15,004 truncating revision to first 12 chars 2016-05-17 05:12:15,005 Setting DEBUG logging. 2016-05-17 05:12:15,005 attempt 1/10 2016-05-17 05:12:15,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a884b96685aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 05:12:15,605 unpacking tar archive at: mozilla-central-a884b96685aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.858306 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:15.808253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:15.808779) ========= script_repo_revision: a884b96685aa13b65601feddb24e5f85ba861561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:15.809452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:15.809769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 05:12:15.824953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 37 secs) (at 2016-05-17 05:12:15.825362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:12:15 INFO - MultiFileLogger online at 20160517 05:12:15 in /builds/slave/test 05:12:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:12:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:15 INFO - {'append_to_log': False, 05:12:15 INFO - 'base_work_dir': '/builds/slave/test', 05:12:15 INFO - 'blob_upload_branch': 'Firefox', 05:12:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:15 INFO - 'branch': 'Firefox', 05:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:16 INFO - 'config_files': ('talos/mac_config.py',), 05:12:16 INFO - 'default_actions': ('clobber', 05:12:16 INFO - 'read-buildbot-config', 05:12:16 INFO - 'download-and-extract', 05:12:16 INFO - 'populate-webroot', 05:12:16 INFO - 'create-virtualenv', 05:12:16 INFO - 'install', 05:12:16 INFO - 'run-tests'), 05:12:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:16 INFO - 'download_minidump_stackwalk': True, 05:12:16 INFO - 'download_symbols': 'ondemand', 05:12:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:16 INFO - 'installer_path': 'installer.exe', 05:12:16 INFO - 'log_level': 'info', 05:12:16 INFO - 'log_name': 'talos', 05:12:16 INFO - 'log_to_console': True, 05:12:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:12:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:12:16 INFO - 'opt_config_files': (), 05:12:16 INFO - 'pip_index': False, 05:12:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:16 INFO - 'cmd': ('bash', 05:12:16 INFO - '-c', 05:12:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:16 INFO - 'enabled': True, 05:12:16 INFO - 'halt_on_failure': False, 05:12:16 INFO - 'name': 'check_screen_resolution'},), 05:12:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:16 INFO - 'cmd': ('bash', 05:12:16 INFO - '-c', 05:12:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:16 INFO - 'enabled': True, 05:12:16 INFO - 'halt_on_failure': False, 05:12:16 INFO - 'name': 'check_screen_resolution'},), 05:12:16 INFO - 'run_cmd_checks_enabled': True, 05:12:16 INFO - 'sps_profile': False, 05:12:16 INFO - 'sps_profile_interval': 0, 05:12:16 INFO - 'suite': 'dromaeojs-e10s', 05:12:16 INFO - 'system_bits': '32', 05:12:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:16 INFO - 'title': 't-yosemite-r7-0305', 05:12:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:16 INFO - 'use_talos_json': True, 05:12:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:16 INFO - 'work_dir': 'build'} 05:12:16 INFO - ##### 05:12:16 INFO - ##### Running clobber step. 05:12:16 INFO - ##### 05:12:16 INFO - Running pre-action listener: _resource_record_pre_action 05:12:16 INFO - Running main action method: clobber 05:12:16 INFO - rmtree: /builds/slave/test/build 05:12:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:17 INFO - Running post-action listener: _resource_record_post_action 05:12:17 INFO - ##### 05:12:17 INFO - ##### Finished clobber step (success) 05:12:17 INFO - ##### 05:12:17 INFO - ##### 05:12:17 INFO - ##### Running read-buildbot-config step. 05:12:17 INFO - ##### 05:12:17 INFO - Running pre-action listener: _resource_record_pre_action 05:12:17 INFO - Running main action method: read_buildbot_config 05:12:17 INFO - Using buildbot properties: 05:12:17 INFO - { 05:12:17 INFO - "project": "", 05:12:17 INFO - "product": "firefox", 05:12:17 INFO - "script_repo_revision": "production", 05:12:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:12:17 INFO - "repository": "", 05:12:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:12:17 INFO - "buildid": "20160517030211", 05:12:17 INFO - "stage_platform": "macosx64", 05:12:17 INFO - "basedir": "/builds/slave/test", 05:12:17 INFO - "nightly_build": "True", 05:12:17 INFO - "buildnumber": 276, 05:12:17 INFO - "slavename": "t-yosemite-r7-0305", 05:12:17 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:12:17 INFO - "platform": "yosemite_r7", 05:12:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:12:17 INFO - "branch": "mozilla-central", 05:12:17 INFO - "repo_path": "mozilla-central", 05:12:17 INFO - "revision": "a884b96685aa13b65601feddb24e5f85ba861561", 05:12:17 INFO - "pgo_build": "False", 05:12:17 INFO - "builduid": "4782507b8501407684e187013b538914", 05:12:17 INFO - "slavebuilddir": "test" 05:12:17 INFO - } 05:12:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:12:17 INFO - Running post-action listener: _resource_record_post_action 05:12:17 INFO - ##### 05:12:17 INFO - ##### Finished read-buildbot-config step (success) 05:12:17 INFO - ##### 05:12:17 INFO - ##### 05:12:17 INFO - ##### Running download-and-extract step. 05:12:17 INFO - ##### 05:12:17 INFO - Running pre-action listener: _resource_record_pre_action 05:12:17 INFO - Running main action method: download_and_extract 05:12:17 INFO - mkdir: /builds/slave/test/build/tests 05:12: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')]} 05:12:17 INFO - https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:12:26 INFO - retry: attempt #1 caught exception: '' 05:12:26 INFO - retry: Failed, sleeping 30 seconds before retrying 05:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 05:13:26 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 05:13:26 INFO - retry: attempt #2 caught exception: timed out 05:13:26 INFO - retry: Failed, sleeping 60 seconds before retrying 05:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #3 05:14:43 INFO - Downloaded 1199 bytes. 05:14:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:14:43 INFO - Using the following test package requirements: 05:14:43 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:14:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:14:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:14:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'jsshell-mac.zip'], 05:14:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:14:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:14:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:14:43 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:14:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:14:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:14:43 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:14:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:43 INFO - https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:46 INFO - Downloaded 18267766 bytes. 05:14:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:49 INFO - Return code: 0 05:14:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:49 INFO - https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:50 INFO - Downloaded 18267766 bytes. 05:14:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:54 INFO - Return code: 0 05:14: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')]} 05:14:54 INFO - https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:14:56 INFO - Downloaded 10840194 bytes. 05:14:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:14:56 INFO - Return code: 0 05:14:56 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')]} 05:14:56 INFO - https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:14:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:14:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:14:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:14:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:14:59 INFO - Downloaded 110107540 bytes. 05:14:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:14:59 INFO - mkdir: /builds/slave/test/properties 05:14:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:59 INFO - Contents: 05:14:59 INFO - build_url:https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - Running post-action listener: set_extra_try_arguments 05:15:01 INFO - ##### 05:15:01 INFO - ##### Finished download-and-extract step (success) 05:15:01 INFO - ##### 05:15:01 INFO - ##### 05:15:01 INFO - ##### Running populate-webroot step. 05:15:01 INFO - ##### 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: populate_webroot 05:15:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:01 INFO - '--tppagecycles', 05:15:01 INFO - '7'], 05:15:01 INFO - 'tests': ['tsvgm']}}, 05:15:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['damp', 'tps']}, 05:15:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'tests': ['damp', 'tps']}, 05:15:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['dromaeo_dom']}, 05:15:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['a11yr', 05:15:01 INFO - 'ts_paint', 05:15:01 INFO - 'tpaint', 05:15:01 INFO - 'sessionrestore', 05:15:01 INFO - 'sessionrestore_no_auto_restore', 05:15:01 INFO - 'tabpaint']}, 05:15:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['tsvgx', 05:15:01 INFO - 'tsvgr_opacity', 05:15:01 INFO - 'tart', 05:15:01 INFO - 'tscrollx', 05:15:01 INFO - 'cart']}, 05:15:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:01 INFO - 'tsvgr_opacity', 05:15:01 INFO - 'tart', 05:15:01 INFO - 'tscrollx', 05:15:01 INFO - 'cart']}, 05:15:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'talos_options': ['--disable-e10s'], 05:15:01 INFO - 'tests': ['tp5o']}, 05:15:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'tests': ['tp5o']}, 05:15:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'talos_options': ['--disable-e10s', 05:15:01 INFO - '--xperf_path', 05:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:01 INFO - 'tests': ['tp5n']}, 05:15:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:01 INFO - 'talos_options': ['--xperf_path', 05:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:01 INFO - 'tests': ['tp5n']}}, 05:15:01 INFO - 'talos.zip': {'path': '', 05:15:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - ##### 05:15:01 INFO - ##### Finished populate-webroot step (success) 05:15:01 INFO - ##### 05:15:01 INFO - ##### 05:15:01 INFO - ##### Running create-virtualenv step. 05:15:01 INFO - ##### 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: create_virtualenv 05:15:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:01 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 05:15:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:01 INFO - Using real prefix '/tools/python27' 05:15:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:04 INFO - Installing pip.................done. 05:15:04 INFO - Return code: 0 05:15:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:04 INFO - 'HOME': '/Users/cltbld', 05:15:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:04 INFO - 'LOGNAME': 'cltbld', 05:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:04 INFO - 'MOZ_NO_REMOTE': '1', 05:15:04 INFO - 'NO_EM_RESTART': '1', 05:15:04 INFO - 'PAGER': '/bin/cat', 05:15:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:04 INFO - 'PWD': '/builds/slave/test', 05:15:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:04 INFO - 'SHELL': '/bin/bash', 05:15:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:04 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:04 INFO - 'USER': 'cltbld', 05:15:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:04 INFO - 'XPC_FLAGS': '0x0', 05:15:04 INFO - 'XPC_SERVICE_NAME': '0', 05:15:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:05 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 05:15:05 INFO - Cleaning up... 05:15:05 INFO - Return code: 0 05:15:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:05 INFO - 'HOME': '/Users/cltbld', 05:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:05 INFO - 'LOGNAME': 'cltbld', 05:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:05 INFO - 'MOZ_NO_REMOTE': '1', 05:15:05 INFO - 'NO_EM_RESTART': '1', 05:15:05 INFO - 'PAGER': '/bin/cat', 05:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:05 INFO - 'PWD': '/builds/slave/test', 05:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:05 INFO - 'SHELL': '/bin/bash', 05:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:05 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:05 INFO - 'USER': 'cltbld', 05:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:05 INFO - 'XPC_FLAGS': '0x0', 05:15:05 INFO - 'XPC_SERVICE_NAME': '0', 05:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:05 INFO - Downloading/unpacking psutil>=3.1.1 05:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:08 INFO - Installing collected packages: psutil 05:15:08 INFO - Running setup.py install for psutil 05:15:08 INFO - building 'psutil._psutil_osx' extension 05:15:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:15:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:15:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:15:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:15:09 INFO - building 'psutil._psutil_posix' extension 05:15:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:15:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:15:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:15:09 INFO - ^ 05:15:09 INFO - 1 warning generated. 05:15:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:09 INFO - Successfully installed psutil 05:15:09 INFO - Cleaning up... 05:15:09 INFO - Return code: 0 05:15:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:09 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')]} 05:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:09 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')]} 05:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:09 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:09 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 05:15:09 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 05:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:09 INFO - 'HOME': '/Users/cltbld', 05:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:09 INFO - 'LOGNAME': 'cltbld', 05:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:09 INFO - 'MOZ_NO_REMOTE': '1', 05:15:09 INFO - 'NO_EM_RESTART': '1', 05:15:09 INFO - 'PAGER': '/bin/cat', 05:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:09 INFO - 'PWD': '/builds/slave/test', 05:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:09 INFO - 'SHELL': '/bin/bash', 05:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:09 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:09 INFO - 'USER': 'cltbld', 05:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:09 INFO - 'XPC_FLAGS': '0x0', 05:15:09 INFO - 'XPC_SERVICE_NAME': '0', 05:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:12 INFO - Installing collected packages: mozsystemmonitor 05:15:12 INFO - Running setup.py install for mozsystemmonitor 05:15:12 INFO - Successfully installed mozsystemmonitor 05:15:12 INFO - Cleaning up... 05:15:12 INFO - Return code: 0 05:15:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15: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 blobuploader==1.2.4 05:15:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:12 INFO - 'HOME': '/Users/cltbld', 05:15:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:12 INFO - 'LOGNAME': 'cltbld', 05:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:12 INFO - 'MOZ_NO_REMOTE': '1', 05:15:12 INFO - 'NO_EM_RESTART': '1', 05:15:12 INFO - 'PAGER': '/bin/cat', 05:15:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:12 INFO - 'PWD': '/builds/slave/test', 05:15:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:12 INFO - 'SHELL': '/bin/bash', 05:15:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:12 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:12 INFO - 'USER': 'cltbld', 05:15:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:12 INFO - 'XPC_FLAGS': '0x0', 05:15:12 INFO - 'XPC_SERVICE_NAME': '0', 05:15:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 INFO - Downloading docopt-0.6.1.tar.gz 05:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:16 INFO - Running setup.py install for blobuploader 05:15:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:16 INFO - Running setup.py install for requests 05:15:17 INFO - Running setup.py install for docopt 05:15:17 INFO - Successfully installed blobuploader requests docopt 05:15:17 INFO - Cleaning up... 05:15:17 INFO - Return code: 0 05:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:17 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:17 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 05:15:17 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 05:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:17 INFO - 'HOME': '/Users/cltbld', 05:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:17 INFO - 'LOGNAME': 'cltbld', 05:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:17 INFO - 'MOZ_NO_REMOTE': '1', 05:15:17 INFO - 'NO_EM_RESTART': '1', 05:15:17 INFO - 'PAGER': '/bin/cat', 05:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:17 INFO - 'PWD': '/builds/slave/test', 05:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:17 INFO - 'SHELL': '/bin/bash', 05:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:17 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:17 INFO - 'USER': 'cltbld', 05:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:17 INFO - 'XPC_FLAGS': '0x0', 05:15:17 INFO - 'XPC_SERVICE_NAME': '0', 05:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-M8nlF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-mOOQmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-3plZsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7etYFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-YXoGGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Ld7eo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-uGjB4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-u1lLbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RJT9jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-LtGVs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Va5SJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-1iS5py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:19 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-x12yvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:19 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_P8qzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:19 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-iqY19k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:19 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-sbadUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:19 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-pYQZe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:19 INFO - Running setup.py install for manifestparser 05:15:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:19 INFO - Running setup.py install for mozcrash 05:15:19 INFO - Running setup.py install for mozdebug 05:15:20 INFO - Running setup.py install for mozdevice 05:15:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Running setup.py install for mozfile 05:15:20 INFO - Running setup.py install for mozhttpd 05:15:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Running setup.py install for mozinfo 05:15:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Running setup.py install for mozInstall 05:15:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:20 INFO - Running setup.py install for mozleak 05:15:20 INFO - Running setup.py install for mozlog 05:15:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Running setup.py install for moznetwork 05:15:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Running setup.py install for mozprocess 05:15:21 INFO - Running setup.py install for mozprofile 05:15:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Running setup.py install for mozrunner 05:15:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:21 INFO - Running setup.py install for mozscreenshot 05:15:21 INFO - Running setup.py install for moztest 05:15:22 INFO - Running setup.py install for mozversion 05:15:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:22 INFO - Cleaning up... 05:15:22 INFO - Return code: 0 05:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:22 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')]} 05:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:22 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')]} 05:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:22 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:22 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 05:15:22 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 05:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:22 INFO - 'HOME': '/Users/cltbld', 05:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:22 INFO - 'LOGNAME': 'cltbld', 05:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:22 INFO - 'MOZ_NO_REMOTE': '1', 05:15:22 INFO - 'NO_EM_RESTART': '1', 05:15:22 INFO - 'PAGER': '/bin/cat', 05:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:22 INFO - 'PWD': '/builds/slave/test', 05:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:22 INFO - 'SHELL': '/bin/bash', 05:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:22 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:22 INFO - 'USER': 'cltbld', 05:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:22 INFO - 'XPC_FLAGS': '0x0', 05:15:22 INFO - 'XPC_SERVICE_NAME': '0', 05:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-b7bmdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:22 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)) 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RfCBBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:22 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)) 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-zzy1wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:22 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)) 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-CBMpds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:22 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)) 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-eojO8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:22 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)) 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-2refv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RP0I_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-TPchW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-2XaWIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-dpqqlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-D1CG94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Kc3mc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-FKwDQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-OAZi47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:23 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)) 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:23 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-V2inaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:24 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)) 05:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:24 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-UOCsrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:24 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)) 05:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:24 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-gZF2Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:24 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)) 05:15:24 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)) 05:15:24 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)) 05:15:24 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)) 05:15:24 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)) 05:15:24 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)) 05:15:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:24 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 05:15:24 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 05:15:24 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 05:15:24 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 05:15:24 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 05:15:24 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 05:15:26 INFO - Downloading blessings-1.6.tar.gz 05:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:26 INFO - Installing collected packages: blessings 05:15:26 INFO - Running setup.py install for blessings 05:15:26 INFO - Successfully installed blessings 05:15:26 INFO - Cleaning up... 05:15:26 INFO - Return code: 0 05:15:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:27 INFO - Reading from file tmpfile_stdout 05:15:27 INFO - Current package versions: 05:15:27 INFO - blessings == 1.6 05:15:27 INFO - blobuploader == 1.2.4 05:15:27 INFO - docopt == 0.6.1 05:15:27 INFO - manifestparser == 1.1 05:15:27 INFO - mozInstall == 1.12 05:15:27 INFO - mozcrash == 0.17 05:15:27 INFO - mozdebug == 0.1 05:15:27 INFO - mozdevice == 0.48 05:15:27 INFO - mozfile == 1.2 05:15:27 INFO - mozhttpd == 0.7 05:15:27 INFO - mozinfo == 0.9 05:15:27 INFO - mozleak == 0.1 05:15:27 INFO - mozlog == 3.2 05:15:27 INFO - moznetwork == 0.27 05:15:27 INFO - mozprocess == 0.22 05:15:27 INFO - mozprofile == 0.28 05:15:27 INFO - mozrunner == 6.11 05:15:27 INFO - mozscreenshot == 0.1 05:15:27 INFO - mozsystemmonitor == 0.3 05:15:27 INFO - moztest == 0.7 05:15:27 INFO - mozversion == 1.4 05:15:27 INFO - psutil == 3.1.1 05:15:27 INFO - requests == 1.2.3 05:15:27 INFO - wsgiref == 0.1.2 05:15:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:27 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:27 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 05:15:27 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 05:15:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:27 INFO - 'HOME': '/Users/cltbld', 05:15:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:27 INFO - 'LOGNAME': 'cltbld', 05:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:27 INFO - 'MOZ_NO_REMOTE': '1', 05:15:27 INFO - 'NO_EM_RESTART': '1', 05:15:27 INFO - 'PAGER': '/bin/cat', 05:15:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:27 INFO - 'PWD': '/builds/slave/test', 05:15:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:27 INFO - 'SHELL': '/bin/bash', 05:15:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:27 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:27 INFO - 'USER': 'cltbld', 05:15:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:27 INFO - 'XPC_FLAGS': '0x0', 05:15:27 INFO - 'XPC_SERVICE_NAME': '0', 05:15:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 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)) 05:15:27 INFO - Cleaning up... 05:15:27 INFO - Return code: 0 05:15:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:27 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:27 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 05:15:27 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 05:15:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:27 INFO - 'HOME': '/Users/cltbld', 05:15:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:27 INFO - 'LOGNAME': 'cltbld', 05:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:27 INFO - 'MOZ_NO_REMOTE': '1', 05:15:27 INFO - 'NO_EM_RESTART': '1', 05:15:27 INFO - 'PAGER': '/bin/cat', 05:15:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:27 INFO - 'PWD': '/builds/slave/test', 05:15:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:27 INFO - 'SHELL': '/bin/bash', 05:15:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:27 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:27 INFO - 'USER': 'cltbld', 05:15:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:27 INFO - 'XPC_FLAGS': '0x0', 05:15:27 INFO - 'XPC_SERVICE_NAME': '0', 05:15:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:27 INFO - Downloading/unpacking jsonschema 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:30 INFO - warning: no files found matching '*.txt' 05:15:30 INFO - no previously-included directories found matching 'build' 05:15:30 INFO - no previously-included directories found matching 'dist' 05:15:30 INFO - no previously-included directories found matching '.git*' 05:15:30 INFO - Installing collected packages: jsonschema, functools32 05:15:31 INFO - Running setup.py install for functools32 05:15:31 INFO - warning: no files found matching '*.txt' 05:15:31 INFO - no previously-included directories found matching 'build' 05:15:31 INFO - no previously-included directories found matching 'dist' 05:15:31 INFO - no previously-included directories found matching '.git*' 05:15:31 INFO - Successfully installed jsonschema functools32 05:15:31 INFO - Cleaning up... 05:15:31 INFO - Return code: 0 05:15:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:15:31 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')]} 05:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 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')]} 05:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 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 0x105d85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca0d85ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:31 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 05:15:31 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 05:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:31 INFO - 'HOME': '/Users/cltbld', 05:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:31 INFO - 'LOGNAME': 'cltbld', 05:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:31 INFO - 'MOZ_NO_REMOTE': '1', 05:15:31 INFO - 'NO_EM_RESTART': '1', 05:15:31 INFO - 'PAGER': '/bin/cat', 05:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:31 INFO - 'PWD': '/builds/slave/test', 05:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:31 INFO - 'SHELL': '/bin/bash', 05:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:15:31 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:31 INFO - 'USER': 'cltbld', 05:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:31 INFO - 'XPC_FLAGS': '0x0', 05:15:31 INFO - 'XPC_SERVICE_NAME': '0', 05:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:31 INFO - Downloading/unpacking flake8 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:34 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 05:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:35 INFO - no previously-included directories found matching 'docs/_build' 05:15:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:35 INFO - Running setup.py install for pep8 05:15:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:35 INFO - no previously-included directories found matching 'docs/_build' 05:15:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:35 INFO - Cleaning up... 05:15:35 INFO - Return code: 0 05:15:35 INFO - Running post-action listener: _resource_record_post_action 05:15:35 INFO - Running post-action listener: _start_resource_monitoring 05:15:35 INFO - Starting resource monitoring. 05:15:35 INFO - ##### 05:15:35 INFO - ##### Finished create-virtualenv step (success) 05:15:35 INFO - ##### 05:15:35 INFO - ##### 05:15:35 INFO - ##### Running install step. 05:15:35 INFO - ##### 05:15:35 INFO - Running pre-action listener: _resource_record_pre_action 05:15:35 INFO - Running main action method: install 05:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:35 INFO - Reading from file tmpfile_stdout 05:15:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:35 INFO - Reading from file tmpfile_stdout 05:15:35 INFO - Output received: 05:15:35 INFO - Usage: mozinstall [options] installer 05:15:35 INFO - Options: 05:15:35 INFO - -h, --help show this help message and exit 05:15:35 INFO - -d DEST, --destination=DEST 05:15:35 INFO - Directory to install application into. [default: 05:15:35 INFO - "/builds/slave/test"] 05:15:35 INFO - --app=APP Application being installed. [default: firefox] 05:15:35 INFO - mkdir: /builds/slave/test/build/application 05:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:16:10 INFO - Reading from file tmpfile_stdout 05:16:10 INFO - Output received: 05:16:10 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:16:10 INFO - Running post-action listener: _resource_record_post_action 05:16:10 INFO - ##### 05:16:10 INFO - ##### Finished install step (success) 05:16:10 INFO - ##### 05:16:10 INFO - ##### 05:16:10 INFO - ##### Running run-tests step. 05:16:10 INFO - ##### 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running main action method: run_tests 05:16:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:10 INFO - 2016-05-17 05:16:10.435 screenresolution[1649:8702] starting screenresolution argv=screenresolution get 05:16:10 INFO - 2016-05-17 05:16:10.438 screenresolution[1649:8702] Display 0: 1600x1200x32@60 05:16:10 INFO - 2016-05-17 05:16:10.444 screenresolution[1650:8704] starting screenresolution argv=screenresolution list 05:16:10 INFO - Available Modes on Display 0 05:16:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:10 INFO - Intel Iris: 05:16:10 INFO - Chipset Model: Intel Iris 05:16:10 INFO - Type: GPU 05:16:10 INFO - Bus: Built-In 05:16:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:10 INFO - Vendor: Intel (0x8086) 05:16:10 INFO - Device ID: 0x0a2e 05:16:10 INFO - Revision ID: 0x0009 05:16:10 INFO - Displays: 05:16:10 INFO - Display: 05:16:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:10 INFO - Display Serial Number: 1600x1200 60 05:16:10 INFO - Main Display: Yes 05:16:10 INFO - Mirror: Off 05:16:10 INFO - Online: Yes 05:16:10 INFO - Rotation: Supported 05:16:10 INFO - Return code: 0 05:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:10 INFO - Python 2.7.3 05:16:10 INFO - Return code: 0 05:16:10 INFO - grabbing minidump binary from tooltool 05:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:10 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/macosx64/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 0x105c29d30>, '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 0x105a4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c20b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:10 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:10 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:16:10 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:16:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:10 INFO - Return code: 0 05:16:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:11 INFO - Return code: 0 05:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --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 05:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OdPu8SIJE/Render', 05:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:11 INFO - 'HOME': '/Users/cltbld', 05:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PAGER': '/bin/cat', 05:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DacqPdt43s/Listeners', 05:16:11 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 05:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - 'XPC_FLAGS': '0x0', 05:16:11 INFO - 'XPC_SERVICE_NAME': '0', 05:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 05:16:12 INFO - mozversion application_buildid: 20160517030211 05:16:12 INFO - mozversion application_changeset: a884b96685aa13b65601feddb24e5f85ba861561 05:16:12 INFO - mozversion application_display_name: Nightly 05:16:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:12 INFO - mozversion application_name: Firefox 05:16:12 INFO - mozversion application_remotingname: firefox 05:16:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:12 INFO - mozversion application_vendor: Mozilla 05:16:12 INFO - mozversion application_version: 49.0a1 05:16:12 INFO - mozversion platform_buildid: 20160517030211 05:16:12 INFO - mozversion platform_changeset: a884b96685aa13b65601feddb24e5f85ba861561 05:16:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:12 INFO - mozversion platform_version: 49.0a1 05:16:12 INFO - using testdate: 1463487372 05:16:12 INFO - actual date: 1463487372 05:16:12 INFO - starting webserver on 'localhost:49278' 05:16:12 INFO - SUITE-START | Running 2 tests 05:16:12 INFO - TEST-START | dromaeo_css 05:16:12 INFO - operating with platform_type : mac_ 05:16:12 INFO - Initialising browser for dromaeo_css test... 05:16:12 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpCZdm0q/profile http://localhost:49278/getInfo.html) 05:16:15 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:16:15 INFO - PROCESS | 1668 | colorDepth:24 05:16:15 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:16:15 INFO - PROCESS | 1668 | __metrics 05:16:15 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:16:16 INFO - TEST-INFO | 1668: exit 0 05:16:16 INFO - Browser initialized. 05:16:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpCZdm0q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:28 INFO - PROCESS | 1673 | RSS: Main: 249761792 05:16:28 INFO - PROCESS | 1673 | 05:17:17 INFO - PROCESS | 1673 | 1463487437844 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] 05:19:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:19:30 INFO - PROCESS | 1673 | RSS: Main: 261648384 05:19:30 INFO - PROCESS | 1673 | 05:22:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:22:33 INFO - PROCESS | 1673 | RSS: Main: 273784832 05:22:33 INFO - PROCESS | 1673 | 05:25:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:25:36 INFO - PROCESS | 1673 | RSS: Main: 275668992 05:25:36 INFO - PROCESS | 1673 | 05:28:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:28:38 INFO - PROCESS | 1673 | RSS: Main: 277245952 05:28:38 INFO - PROCESS | 1673 | 05:31:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:31:41 INFO - PROCESS | 1673 | RSS: Main: 280113152 05:31:41 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:34:44 INFO - PROCESS | 1673 | RSS: Main: 281300992 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | __start_tp_report 05:34:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 05:34:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 05:34:44 INFO - PROCESS | 1673 | |i|pagename|runs| 05:34:44 INFO - PROCESS | 1673 | |0;dojo.html;3504.7021003214727;3507.9649203507965;3528.294341131773;3548.591911930129;3571.17862891535;5862.76548938043;5934.970325148379;5945.732442040113;6044.063170208614;6051.122587224861;5760.337561180466;5881.117832325142;5910.586258961875;5916.1125831125355;6041.305249896263;5209.348831396075;5250.763715632786;5341.584480112773;5353.973230133844;5367.329083864517;870.7587097391263;5277.076511610472;5283.55089817366;5298.973505132469;5391.083515802323;4440.844570440036;5349.144136938091;5367.597430192751;5368.812091576776;5389.946100538984;5376.811811586615;5399.325084364455;5407.270018547524;5424.701641409721;5432.2123292122815;5234.7120908350025;5253.842384728464;5274.55166310864;5315.495027972375;5368.731563421852;5668.43315668434;5858.502027327682;5883.294004719418;5888.02847530157;5950.166976623276;5925;6252.343503932113;6270.341614130496;6271.5923464975085;6285.59143655661;5396.64921780083;6147.9548476759055;6204.317525072239;6210;6212.502999760053;5054.7472626368535;6000.399960004008;6013.51891848651;6017.338092809831;6058.96970515149;5130.692158470503;6403.807885763435;6404.359564043559;6406.679666016774;6413.518986075969;6183.196184495987;6221.688915554204;6236.563440559208;6280.152179455807;6284.591501552384;6205.162303089115;6254.593451425642;6277.937220627827;6279.905801412982;6297.370262973757;6137.285055221596;6154;6214.912390331674;6245.281792593819;6250.937490625127;5321.680699158062;5943.405659434022;6148.600340977822;6242.5942313750365;6250.874982500324;4326.913461730748;4482.439695038121;4681.063787242497;5073.315102461194;5124.590032797368;4490.281554951257;4506.819727210875;4527.071950250191;4550.180967425829;4577.839775607904;5846.1523079153285;5942.732577034044;5973.910391344133;5987.730552125165;6005.6997150142315;6254.15568898202;6275.184226050585;6276.6547839868335;6294;6297;5870.14882841994;5923.496502797224;5986.431289027535;6035.486983606443;6050.878982420327;5505.284313039279;5508.614396992252;5521.861953451115;5523.392426833045;5544.944550554524;6431.903521447182;6439.9356006440275;6457.418832305021;6457.773977910939;6457.935420645734;6132.967444181115;6192.195014648067;6203;6254.155688981929;6266.937330626635;6425.1004859320665;6438.291787903233;6450.000249961264;6462.418382345423;6478.546501744832;6251.187345645037;6256.155419018374;6257.2491301044165;6258.780942666985;6260;6125.815438131457;6182.598131121463;6193.318734939063;6193.752249910133;6273.874522509615;5372.5433338166695;6199;6254.499640028877;6259.6870156492905;6271.24745030581;6180.134781130735;6258.405451482102;6267.9373206267355;6276.152719382825;6320.083587879823;4889.853304400732;5965.343812180743;6078.756849726138;6098.847528811638;6166.876662466815;5766.019776638065;5970.134330522137;6201;6218.81343559694;6225.128482012612;5430.13117901134;6172.85802126608;6205.6586887721605;6223;6236 05:34:44 INFO - PROCESS | 1673 | |1;ext.html;491.1061867401329;512.5591990887837;516.1947362115101;516.6280278199695;544.8748334688864;38380.353866382684;41050.38424423629;41182.79408602953;41208.793956030175;41248.175036499255;41869.79065104678;42094.57905420945;42535.78732106343;42662;42760;9662.468564228964;9860.60557577696;9880.654177103803;9884.11043006133;9901.257405694565;9581.281403894702;9624.855627165563;9682.612695492171;9707.029297070307;9729.173020293283;9626.278029147841;9725.27060470464;9725.610975560969;9732.978037306088;9764.316497845119;9674.661386851461;9702.611895524242;9723.367981081243;9728.854067188999;9771.657991970247;9632.133108020313;9688.90311096894;9693.563789629483;9696.36973596721;9723.951380243125;39080;39091.21817563633;39287.21425571472;39526.81419557418;39643;2799.594058861474;3021.3202029543395;3035.7874948753597;3358.9664103358896;3360.865565377382;25756.742432575622;26856;27891.581626275623;28531.714682853115;28583.28541786451;2622.1740151852105;2650.1651979626354;2692.367293685982;2720.3063218879256;2722.1153125234378;431633;435532;436372;437548;439248.8037559824;33556.66443335584;34329.14177145541;34628.826855866064;34636.82681586576;35329.646703532635;36653.63346366502;36846.44730329047;37141.442878356844;37188.62811371906;37190.8140459296;15096.320665570076;15192.620184495256;15204.011739236914;15252.847471525365;15349.232538373037;12334.568290109803;12772.169808962388;12915.289659068654;12920.870791292155;12925.159864608959;8210.589470526449;8228.876566851503;8234.917650823534;8273.503589784512;8360.874586881202;3441.776284541497;3445.707114895262;3459.429194182982;3463.7921724696093;3471.2536804587135;923.3444254579324;983.5672304186136;990.6334656177261;1018.6434747838346;1042.9309957293835;25896.446213227267;26194.86902565513;29474;29814.10557683273;30098.946536871543;962.4898803634085;998.8601595776597;1040.2354269611828;1069.454578165126;1162.616336608917;15032.248387580796;15195.240237988057;15617.921910390376;15781.921090394475;15888.76166857498;655241;669258;669300;671841;672530;59072;60727;60772;60864.39135608587;60956.695216523636;1207.4988879615037;1441.4018182454374;1473.661057956676;1486.0934829753842;1494.5740463967718;26933.461330772883;29542.261443464085;29817;29927.653255603116;30564.694353056184;51008.74495627498;51018.234726479874;51733.7413312931;51963.220551690996;51969.740151299;587466;594976;599849;600455;601434;26128;26388.604170937066;26786.59820102739;27550.035748748698;28062.43875122527;38435.80782096072;45154.322685159095;46038.39616038503;46238.53761462343;47168.820779479414;36404.453933190496;37931.051723707125;38181.618183818915;38595.421068684554;38619.80690096531;36985;37138.814305928296;37377.43933841049;37625.2474950494;38284.85145445641;31635.84182079075;37176.81411592925;37796.43305350367;38066.80966595149;38528.42207366948;29096.854515727286;31991.360172796878;33425.49861752027;34572.481412778325;35013.47479787856;24804.875975620005;24851.627225591994;24893.87553062223;25459.872700636377;25532.74467255378 05:34:44 INFO - PROCESS | 1673 | |2;jquery.html;336.7087469339021;348.6931500279753;391.7062203347489;402.1113339519661;412.0687246822181;19650.312239071634;20174.49563760903;21887.562248755035;22150.446238844037;22219.333419997387;11319.603813866517;11812.350320732356;11842.881571184285;11865.406729663526;18707.812921870776;5178.689278643294;5347.224652425396;5355.0628639988045;5359.464053594629;5374.381946076212;3820.2168555446065;5683.090705487123;5999.190109335249;6011.5491338149595;6027.879442411149;5365.356157261134;6015.127806468059;6021.789237376693;6027.517798576126;6033.758649654009;5692.800751973682;5692.943070569283;5789.681567513785;5801.187833703264;5817.767289308423;5420.810271640513;5574.331080270353;5703;5716.657000579979;5722.9141562876175;12584.937075314656;12853.100282980195;14271.643208919757;20217.696734548994;22831.885840570856;1952.306931039489;1985.5234743661563;2009.577988622391;2062.391594479632;2164.296603603819;7998.960005199995;9610.855837162448;9712.61149554017;9728.41629502225;9895.653652122213;1411.4142630808306;1543.49064808614;1659.2450435052021;1720.0797573298225;1740.704080306351;107529;117512.41243793727;118546;131176;132038.33980830034;11576;11795.41022948849;11822.645320640395;11831.88168118325;11925.986291165349;15221.391144354102;15235.466758663393;15243.695126097417;15247.542573722805;15256.771148432783;8808.075152109064;8860;8875.600597973107;8922.955385223033;8981.550922453851;8764.430312029697;8767.605457754416;8783.516906570072;8815.823683526294;8874.068222836639;4564.908701825945;4602.516735742765;4610.3084537319;4713.387259656222;4743.0988112258565;1816.7016158875047;1878.64305781901;1887.669657809878;1889.914953827081;1996.5407956169872;748.5733132114642;933.2300851797295;955.8279509688323;999.0259496990376;1027.342500799489;19680.991365366852;20395.388138355574;20509.2821751241;20631;20693.482662933548;862.7756783236404;926.7822061815468;926.8795056642593;966.8549717542285;967.274544091931;5614.522765564891;10479.580816767244;10960.342379457257;11008;11036.448177591248;508844;515839;516919.98480091314;545324;625133.7486625075;119305;139497;140739.29630351783;144300;145882;1031.6131450705984;1034.182995433599;1038.7143535527791;1041.6458404142627;1061.7717190804015;17917;18212.089395530435;18480.445586632424;18513.81486185121;19041.00069492683;37932.81033594815;44557;52651.94696106133;52889.47110528845;53310;79696;80850.59574702088;80897.19102808897;81422.59288703519;81460.370792585;6262.467690246198;7302.3792977597495;7357.816054598464;7541.43439242048;7592.924070759222;8355.665773368997;11817.527298907948;12831.743365132832;12890.871091288967;13229.536966206137;8783.165599268059;8825.426347287406;9362.578683959102;9751.707448776548;11174.217804753589;9226.308026897876;11011.944940275247;11292.491837867152;11353.318800871644;11368.261063031207;5931.881362372815;9758.609655613696;10622.256442048982;11494.597689080842;11556;7270.127584689871;7462.552246865205;7872.72445464406;7944.699540826374;8242;10866.456677166268;11212.27120237182;11275.041621462267;11317.71705707364;11434.256773309708 05:34:44 INFO - PROCESS | 1673 | |3;mootools.html;1597.0417749350388;1647.7445995870642;1849.3619701203097;1908.8759230650007;1977.090538352358;8296.377771667134;8856.15866492683;8866.157715017063;9338.346315757892;9360.625574977;7932.167122452146;8939.195472407482;9011.143941325563;9174.54127293636;9251.861222081658;2400.8319417640773;2440;2443.8655873926928;2446.2049833803994;2448.8040956723507;2416.8187385946035;2416.891239894209;2428.077330614364;2441.5361081394476;2454.987725061372;2392.724836643782;2418.9758102418928;2424.066734307287;2446.2661201639526;2450.889709963056;2058.4750888523404;2386.8806559672034;2394.0663141374876;2427.611582146857;2430.149447693311;2363.6927199463958;2365.207655435431;2386.0813586769045;2401.7117945846435;2414.2274472168915;9080.81838363229;9104.8634270486;9164.495952722598;9218.124278193562;9233.6306547738;5442.12925931849;5586.972065139648;5605.215269862222;5606.803761868356;5610.831675049755;3577.606463289036;3601.2797440512004;3619.7466177367596;3627.3470775260444;3664.725145614063;959.3572306554626;973.124188230591;977.9364341317792;978.6330126202674;996.3274789517047;11865.703357416047;12083.27500349973;12090.939545302304;12095.39523023854;12112;4284.764337961442;4628.958484341064;4807.855764327076;4876.4879687633;4978.2034874419915;10328.793424131476;10341.327813692085;10346.844797328045;10358.585656573803;10366.740831479123;5469.562435005269;5499.890002199933;5569.972150139223;5570.721463926788;5604.915926261109;4308.80610372534;4563.9087218255445;4680.578747912636;5078.568321692624;5109.718965456861;4069.2854322937346;4113.835446582103;4122.525909520384;4152.91694166115;4155.397467367215;1319.7558451686468;1320.1551007355301;1325.840899092115;1328.5947785925193;1331.5672406467936;760.6767123972289;865.8051938313829;872.450356275555;876.1895246896595;930.02812061396;5165;5627.240322556402;5674.319081710221;5674.943250567441;5866.853328666817;860.6901515454431;970.9611615535441;1011.4538149399389;1017.31839667423;1054.620336678795;3312;3550.25444656625;3571.9998400447917;3662.432322989941;3681.7422780405113;11077.446127693584;11159.497822598003;11262.7184320391;11425.257358271685;11437.885621143681;11237.438128093563;11342.319460832376;11400.657980260605;11434.94282528582;11447.25592836463;8144;8467.788305292417;8535.487870727777;8647.221750042401;8652.653893844301;4178.582141785919;4405.29515277554;4592.770361481846;5406.243125962447;5599.384067752625;9340.439573625605;10040.899591003996;10180.847287290548;10446.216533760151;10516.158707303244;10446.270758230858;10580.84128738085;10613.363198208132;10803.351798892092;10813.351198928089;7268.600226987566;7525.736599219001;7615.809604759704;7696.7306144284685;7848.979632647947;8630.223279904587;8635.136486351315;8710.47737135774;8717.476951382938;8726.69456569017;7504.1370242420635;7723.7682869514;7742.6128693566225;7766.378689704697;7792.337651299703;7465.3654439371085;7554.886676699964;7637.732679356196;7710.961445192738;7767.339776119094;7186.89219661695;7222.422206223595;7259.419246460165;7298.6715597797165;7314.08573928259;4486.798094085709;4566.292224705176;4698.647601429838;4722.409698787652;4775.498572649961;4632.374629424984;4667.743274119956;4723.173444647242;4768.690035147704;4792.156668564807 05:34:44 INFO - PROCESS | 1673 | |4;prototype.html;291.2006542042096;300.483168949407;305.05585213763396;308.6311857330491;311.49848743522926;5377.166539186423;5506.944930550693;5601.6358936669085;5651.869626074786;5717.62776933536;4423.77881105945;4471.843485478001;5484.506394424501;5553.361363443195;5602.495775380215;3500.7549471537004;3556.421594344106;3902.9024274393223;4124.690648201382;4140.337545992642;3688.377114069801;3991.720579559432;4140.7515549067;4160.981923766971;4161.063760653859;4087.57080506547;4095.6313931746135;4102.753834769908;4108.630223279904;4141.275276826558;4119.237940980928;4121.629053385194;4121.9587804121875;4141.378793181017;4189.07840275139;3438.9312213755834;3461.9441070473495;3561.4835848802036;3572.356975744365;3583.4624806279007;4956.553910148104;5014.047331007097;5338.893222135574;5389.003034438641;5391.137418013138;3910.921781564353;3958.960410395888;4336.696431249814;4506.616937560311;4683.906321873577;5362.51737343641;5618.101103823409;5776.711164441803;5879.8530036749;5887.764489420418;3365.293288409437;3425.9077526987244;3788.5453745550435;3911.784851833148;3938.940915886264;4844.394450693663;5454.809081682122;6157.7229024694;6193.253081885439;6245.968770156165;3566.32239874423;3933.056066544009;3960.32674445345;3966.155737582038;4023.396490526386;3345.765796394278;3646.08847788053;3700.5744339400776;3711.3690672585726;4015.5181378234797;4668.276417155346;4678.485366609671;4699.801550604574;4719.551642593948;4720.811167553259;5260.710660913686;5387.838364849061;5492.880339745191;5761.798337058183;5847.239858818326;1191.5650787462687;1273.496968697378;1287.5557932513268;1321.5440672967811;1377.2425166158573;701.6596950479013;715.4526787007943;798.9360851131895;812.4800127918137;839.7942504086537;3956.3274243378696;4261.275583150872;4561.608709343615;4619.353290539327;4632.559906808848;4380.430544029319;4586.816527338936;4979.253112033224;5117.718525481134;5166.560842328369;3951.407288906687;4077.4903137107863;4606.963433227497;4616.746078965622;4647.744374059459;2447.3881529617597;2484.391324125601;2537.936551586225;2549.6048112542585;2723.5506141486435;4815.759212039454;4823.539994602778;5262.500062494057;5275.127329797867;5331.1470164773455;4716.3868697069165;4756.7145971241835;5053.216751403538;5178.533931946067;5309.7345132743985;4713.515242698539;5049.31834202378;5206.947930520646;5243.868903277448;5247.242173871796;4291.39920411149;4352.4341835562445;4855.320255164209;5064.96168285508;5109.3613298337705;4456.5043575597765;4473.731576105314;4563.439594050459;4804.663673542818;5008.513974403084;4623.930641040454;4673.789679464364;4673.836415725434;4946.9364086721525;4986.950130498649;2831.433713257398;3060.32672811981;3369.5619569456794;3487.47687846825;3497.4229252173104;4540.772961351985;4784.947311591444;4922.4339200992345;5112.821051263188;5503.394626590992;5390.272313237662;5799.333076696065;5883.235179426647;5926.614770039933;5931.576421658685;5526.060569703241;5549.972250138723;5849.824505264849;5871.4715675589405;5877.207451727264;4791.401074865642;4991.201407774739;4996.775145118551;5651.095824668198;5809.30288365382;5188.896222075613;5559.694216818114;5631.98624247623;5935.851603709769;5944.613600115978;5277.944411117715;5298.231756395378;5383.838484845461;5422.62041657096;5549.724612908688 05:34:44 INFO - PROCESS | 1673 | |5;yui.html;599.9670018149;642.8328634555015;680.8229860236339;718.8993540904274;750.1972889008756;14806.777898331533;14867.141607299074;15222.314995825187;15611.297491612877;15668.529944101667;12281.631551053482;12530.874691253084;14596.197209153519;14607.853921460783;14650.047746896444;712.7434123715484;902.1384577728254;902.5487256371814;921.6728061538158;924.9398789078689;922.8292765838307;930.3115694386173;931.5249222896338;933.2533972821716;935.6771913689801;952.5427794658533;968.293146003418;970.4662435660393;971.5725080964388;971.9757006074834;929.5212965322864;946.1153821177187;958.2382006305004;963.9951800240989;964.1948972607846;707.9646017699095;711.5161690050763;713.4506430048885;714.0217901474961;715.234698872207;14784.852151478563;15122.848771512365;15131.394744210218;15162.772558411632;15184.240787960558;12033.819492707617;12727.299998500079;12746.553870614576;12755.936220318932;12867.485300587965;8773.298136149093;10078.596856125747;10186.439745813977;10275.537600807982;10573.577056917715;3475.565554305712;3538;3544.556930383702;3569.01851990702;3605.2068544920076;92196;94017;94556;95258.52370738171;95916;7845.764627061198;9102.692072761934;9314.673986410444;9469.384490008128;9612.471314077793;21162;21287.68068478943;21387;21476.140954361963;21688.457788555414;6235.625862448268;7494.625268736541;7494.98817659609;7575.431842611826;7626.656800443993;3834.559025712079;3905.1018265799025;3949.308870947573;3954.0114971257185;3957.1689945111275;3443.2941247044296;3536.398812201932;3552.520409744703;3553.626869178751;3558.430651095812;630.9747610095636;633.1958412815699;637.7162162837585;648.2156590525423;650.6421468192475;512.1396054628186;514.8558403646985;548.8518100112947;557.5734563059262;573.7045421607876;8000.6399712011935;8001.239882211181;8122.431429799975;8129.471584347117;8177.386695997824;459.81147729430774;557.90515612346;571.8541771848152;576.8463073852296;596.3231731984229;3549.804760738184;3784.7368813171965;3786.659200671953;3877.166409222031;3974.940375894364;87663.12336876677;88605.55697221472;88925.55537222401;91941.54029229812;94031;82785.58607206926;83087;83790.9052273698;85657.57171214104;85836;58743.706281468316;74774.6261268701;75477;75902.62048689721;77886;7062;8242.784590610678;8258.710945116893;8273.83452330962;8323.93142765876;28004.719952800213;47019.294710580056;47521.762391187825;47950.520494796;48623;51248.71878202925;65361.67319163374;67950;68142.65928670524;68700.96948545876;10466;10726.67819965371;11071.667849964513;11096.389698566656;11281.984621384116;10068.144207742424;11864.169508134348;11965.102617303563;12266.141370104007;12294.20087694297;10849.67450976472;11263.09895208365;11522.53909843597;11613.535458581562;11683.824742629038;11349.10900369963;11507.827382589436;11526.423678816192;11544.076473882238;11553;10404.323718958547;11223;11291.43542822872;11294.491747871201;11452.599159029394;9367.716562941363;9426.24590032782;9564.4739539326;9833;10030.699079027641;9478.620855165716;9631.518424078628;9742.75643108928;9760.707178784647;9789.65736199258 05:34:44 INFO - PROCESS | 1673 | __end_tp_report 05:34:44 INFO - PROCESS | 1673 | __start_cc_report 05:34:44 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,421 05:34:44 INFO - PROCESS | 1673 | __end_cc_report 05:34:44 INFO - PROCESS | 1673 | __startTimestamp1463488484687__endTimestamp 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | ------- Summary: start ------- 05:34:44 INFO - PROCESS | 1673 | Number of tests: 6 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5776.31 Median:6050.88 stddev:751.62 (12.4%) stddev-sans-first:732.50 05:34:44 INFO - PROCESS | 1673 | Values: 3504.7 3508.0 3528.3 3548.6 3571.2 5862.8 5935.0 5945.7 6044.1 6051.1 5760.3 5881.1 5910.6 5916.1 6041.3 5209.3 5250.8 5341.6 5354.0 5367.3 870.8 5277.1 5283.6 5299.0 5391.1 4440.8 5349.1 5367.6 5368.8 5389.9 5376.8 5399.3 5407.3 5424.7 5432.2 5234.7 5253.8 5274.6 5315.5 5368.7 5668.4 5858.5 5883.3 5888.0 5950.2 5925.0 6252.3 6270.3 6271.6 6285.6 5396.6 6148.0 6204.3 6210.0 6212.5 5054.7 6000.4 6013.5 6017.3 6059.0 5130.7 6403.8 6404.4 6406.7 6413.5 6183.2 6221.7 6236.6 6280.2 6284.6 6205.2 6254.6 6277.9 6279.9 6297.4 6137.3 6154.0 6214.9 6245.3 6250.9 5321.7 5943.4 6148.6 6242.6 6250.9 4326.9 4482.4 4681.1 5073.3 5124.6 4490.3 4506.8 4527.1 4550.2 4577.8 5846.2 5942.7 5973.9 5987.7 6005.7 6254.2 6275.2 6276.7 6294.0 6297.0 5870.1 5923.5 5986.4 6035.5 6050.9 5505.3 5508.6 5521.9 5523.4 5544.9 6431.9 6439.9 6457.4 6457.8 6457.9 6133.0 6192.2 6203.0 6254.2 6266.9 6425.1 6438.3 6450.0 6462.4 6478.5 6251.2 6256.2 6257.2 6258.8 6260.0 6125.8 6182.6 6193.3 6193.8 6273.9 5372.5 6199.0 6254.5 6259.7 6271.2 6180.1 6258.4 6267.9 6276.2 6320.1 4889.9 5965.3 6078.8 6098.8 6166.9 5766.0 5970.1 6201.0 6218.8 6225.1 5430.1 6172.9 6205.7 6223.0 6236.0 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:67965.41 Median:38233.23 stddev:154270.75 (403.5%) stddev-sans-first:154620.34 05:34:44 INFO - PROCESS | 1673 | Values: 491.1 512.6 516.2 516.6 544.9 38380.4 41050.4 41182.8 41208.8 41248.2 41869.8 42094.6 42535.8 42662.0 42760.0 9662.5 9860.6 9880.7 9884.1 9901.3 9581.3 9624.9 9682.6 9707.0 9729.2 9626.3 9725.3 9725.6 9733.0 9764.3 9674.7 9702.6 9723.4 9728.9 9771.7 9632.1 9688.9 9693.6 9696.4 9724.0 39080.0 39091.2 39287.2 39526.8 39643.0 2799.6 3021.3 3035.8 3359.0 3360.9 25756.7 26856.0 27891.6 28531.7 28583.3 2622.2 2650.2 2692.4 2720.3 2722.1 431633.0 435532.0 436372.0 437548.0 439248.8 33556.7 34329.1 34628.8 34636.8 35329.6 36653.6 36846.4 37141.4 37188.6 37190.8 15096.3 15192.6 15204.0 15252.8 15349.2 12334.6 12772.2 12915.3 12920.9 12925.2 8210.6 8228.9 8234.9 8273.5 8360.9 3441.8 3445.7 3459.4 3463.8 3471.3 923.3 983.6 990.6 1018.6 1042.9 25896.4 26194.9 29474.0 29814.1 30098.9 962.5 998.9 1040.2 1069.5 1162.6 15032.2 15195.2 15617.9 15781.9 15888.8 655241.0 669258.0 669300.0 671841.0 672530.0 59072.0 60727.0 60772.0 60864.4 60956.7 1207.5 1441.4 1473.7 1486.1 1494.6 26933.5 29542.3 29817.0 29927.7 30564.7 51008.7 51018.2 51733.7 51963.2 51969.7 587466.0 594976.0 599849.0 600455.0 601434.0 26128.0 26388.6 26786.6 27550.0 28062.4 38435.8 45154.3 46038.4 46238.5 47168.8 36404.5 37931.1 38181.6 38595.4 38619.8 36985.0 37138.8 37377.4 37625.2 38284.9 31635.8 37176.8 37796.4 38066.8 38528.4 29096.9 31991.4 33425.5 34572.5 35013.5 24804.9 24851.6 24893.9 25459.9 25532.7 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:33177.14 Median:2105.96 stddev:91933.95 (4365.4%) stddev-sans-first:92158.78 05:34:44 INFO - PROCESS | 1673 | Values: 336.7 348.7 391.7 402.1 412.1 19650.3 20174.5 21887.6 22150.4 22219.3 11319.6 11812.4 11842.9 11865.4 18707.8 5178.7 5347.2 5355.1 5359.5 5374.4 3820.2 5683.1 5999.2 6011.5 6027.9 5365.4 6015.1 6021.8 6027.5 6033.8 5692.8 5692.9 5789.7 5801.2 5817.8 5420.8 5574.3 5703.0 5716.7 5722.9 12584.9 12853.1 14271.6 20217.7 22831.9 1952.3 1985.5 2009.6 2062.4 2164.3 7999.0 9610.9 9712.6 9728.4 9895.7 1411.4 1543.5 1659.2 1720.1 1740.7 107529.0 117512.4 118546.0 131176.0 132038.3 11576.0 11795.4 11822.6 11831.9 11926.0 15221.4 15235.5 15243.7 15247.5 15256.8 8808.1 8860.0 8875.6 8923.0 8981.6 8764.4 8767.6 8783.5 8815.8 8874.1 4564.9 4602.5 4610.3 4713.4 4743.1 1816.7 1878.6 1887.7 1889.9 1996.5 748.6 933.2 955.8 999.0 1027.3 19681.0 20395.4 20509.3 20631.0 20693.5 862.8 926.8 926.9 966.9 967.3 5614.5 10479.6 10960.3 11008.0 11036.4 508844.0 515839.0 516920.0 545324.0 625133.7 119305.0 139497.0 140739.3 144300.0 145882.0 1031.6 1034.2 1038.7 1041.6 1061.8 17917.0 18212.1 18480.4 18513.8 19041.0 37932.8 44557.0 52651.9 52889.5 53310.0 79696.0 80850.6 80897.2 81422.6 81460.4 6262.5 7302.4 7357.8 7541.4 7592.9 8355.7 11817.5 12831.7 12890.9 13229.5 8783.2 8825.4 9362.6 9751.7 11174.2 9226.3 11011.9 11292.5 11353.3 11368.3 5931.9 9758.6 10622.3 11494.6 11556.0 7270.1 7462.6 7872.7 7944.7 8242.0 10866.5 11212.3 11275.0 11317.7 11434.3 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5826.66 Median:4630.67 stddev:3365.87 (72.7%) stddev-sans-first:3360.30 05:34:44 INFO - PROCESS | 1673 | Values: 1597.0 1647.7 1849.4 1908.9 1977.1 8296.4 8856.2 8866.2 9338.3 9360.6 7932.2 8939.2 9011.1 9174.5 9251.9 2400.8 2440.0 2443.9 2446.2 2448.8 2416.8 2416.9 2428.1 2441.5 2455.0 2392.7 2419.0 2424.1 2446.3 2450.9 2058.5 2386.9 2394.1 2427.6 2430.1 2363.7 2365.2 2386.1 2401.7 2414.2 9080.8 9104.9 9164.5 9218.1 9233.6 5442.1 5587.0 5605.2 5606.8 5610.8 3577.6 3601.3 3619.7 3627.3 3664.7 959.4 973.1 977.9 978.6 996.3 11865.7 12083.3 12090.9 12095.4 12112.0 4284.8 4629.0 4807.9 4876.5 4978.2 10328.8 10341.3 10346.8 10358.6 10366.7 5469.6 5499.9 5570.0 5570.7 5604.9 4308.8 4563.9 4680.6 5078.6 5109.7 4069.3 4113.8 4122.5 4152.9 4155.4 1319.8 1320.2 1325.8 1328.6 1331.6 760.7 865.8 872.5 876.2 930.0 5165.0 5627.2 5674.3 5674.9 5866.9 860.7 971.0 1011.5 1017.3 1054.6 3312.0 3550.3 3572.0 3662.4 3681.7 11077.4 11159.5 11262.7 11425.3 11437.9 11237.4 11342.3 11400.7 11434.9 11447.3 8144.0 8467.8 8535.5 8647.2 8652.7 4178.6 4405.3 4592.8 5406.2 5599.4 9340.4 10040.9 10180.8 10446.2 10516.2 10446.3 10580.8 10613.4 10803.4 10813.4 7268.6 7525.7 7615.8 7696.7 7849.0 8630.2 8635.1 8710.5 8717.5 8726.7 7504.1 7723.8 7742.6 7766.4 7792.3 7465.4 7554.9 7637.7 7711.0 7767.3 7186.9 7222.4 7259.4 7298.7 7314.1 4486.8 4566.3 4698.6 4722.4 4775.5 4632.4 4667.7 4723.2 4768.7 4792.2 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:4354.51 Median:4706.66 stddev:1355.98 (28.8%) stddev-sans-first:1325.04 05:34:44 INFO - PROCESS | 1673 | Values: 291.2 300.5 305.1 308.6 311.5 5377.2 5506.9 5601.6 5651.9 5717.6 4423.8 4471.8 5484.5 5553.4 5602.5 3500.8 3556.4 3902.9 4124.7 4140.3 3688.4 3991.7 4140.8 4161.0 4161.1 4087.6 4095.6 4102.8 4108.6 4141.3 4119.2 4121.6 4122.0 4141.4 4189.1 3438.9 3461.9 3561.5 3572.4 3583.5 4956.6 5014.0 5338.9 5389.0 5391.1 3910.9 3959.0 4336.7 4506.6 4683.9 5362.5 5618.1 5776.7 5879.9 5887.8 3365.3 3425.9 3788.5 3911.8 3938.9 4844.4 5454.8 6157.7 6193.3 6246.0 3566.3 3933.1 3960.3 3966.2 4023.4 3345.8 3646.1 3700.6 3711.4 4015.5 4668.3 4678.5 4699.8 4719.6 4720.8 5260.7 5387.8 5492.9 5761.8 5847.2 1191.6 1273.5 1287.6 1321.5 1377.2 701.7 715.5 798.9 812.5 839.8 3956.3 4261.3 4561.6 4619.4 4632.6 4380.4 4586.8 4979.3 5117.7 5166.6 3951.4 4077.5 4607.0 4616.7 4647.7 2447.4 2484.4 2537.9 2549.6 2723.6 4815.8 4823.5 5262.5 5275.1 5331.1 4716.4 4756.7 5053.2 5178.5 5309.7 4713.5 5049.3 5206.9 5243.9 5247.2 4291.4 4352.4 4855.3 5065.0 5109.4 4456.5 4473.7 4563.4 4804.7 5008.5 4623.9 4673.8 4673.8 4946.9 4987.0 2831.4 3060.3 3369.6 3487.5 3497.4 4540.8 4784.9 4922.4 5112.8 5503.4 5390.3 5799.3 5883.2 5926.6 5931.6 5526.1 5550.0 5849.8 5871.5 5877.2 4791.4 4991.2 4996.8 5651.1 5809.3 5188.9 5559.7 5632.0 5935.9 5944.6 5277.9 5298.2 5383.8 5422.6 5549.7 05:34:44 INFO - PROCESS | 1673 | 05:34:44 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18545.46 Median:29670.01 stddev:26829.12 (90.4%) stddev-sans-first:26870.54 05:34:44 INFO - PROCESS | 1673 | Values: 600.0 642.8 680.8 718.9 750.2 14806.8 14867.1 15222.3 15611.3 15668.5 12281.6 12530.9 14596.2 14607.9 14650.0 712.7 902.1 902.5 921.7 924.9 922.8 930.3 931.5 933.3 935.7 952.5 968.3 970.5 971.6 972.0 929.5 946.1 958.2 964.0 964.2 708.0 711.5 713.5 714.0 715.2 14784.9 15122.8 15131.4 15162.8 15184.2 12033.8 12727.3 12746.6 12755.9 12867.5 8773.3 10078.6 10186.4 10275.5 10573.6 3475.6 3538.0 3544.6 3569.0 3605.2 92196.0 94017.0 94556.0 95258.5 95916.0 7845.8 9102.7 9314.7 9469.4 9612.5 21162.0 21287.7 21387.0 21476.1 21688.5 6235.6 7494.6 7495.0 7575.4 7626.7 3834.6 3905.1 3949.3 3954.0 3957.2 3443.3 3536.4 3552.5 3553.6 3558.4 631.0 633.2 637.7 648.2 650.6 512.1 514.9 548.9 557.6 573.7 8000.6 8001.2 8122.4 8129.5 8177.4 459.8 557.9 571.9 576.8 596.3 3549.8 3784.7 3786.7 3877.2 3974.9 87663.1 88605.6 88925.6 91941.5 94031.0 82785.6 83087.0 83790.9 85657.6 85836.0 58743.7 74774.6 75477.0 75902.6 77886.0 7062.0 8242.8 8258.7 8273.8 8323.9 28004.7 47019.3 47521.8 47950.5 48623.0 51248.7 65361.7 67950.0 68142.7 68701.0 10466.0 10726.7 11071.7 11096.4 11282.0 10068.1 11864.2 11965.1 12266.1 12294.2 10849.7 11263.1 11522.5 11613.5 11683.8 11349.1 11507.8 11526.4 11544.1 11553.0 10404.3 11223.0 11291.4 11294.5 11452.6 9367.7 9426.2 9564.5 9833.0 10030.7 9478.6 9631.5 9742.8 9760.7 9789.7 05:34:44 INFO - PROCESS | 1673 | -------- Summary: end -------- 05:34:44 INFO - PROCESS | 1673 | 05:34:45 INFO - TEST-INFO | 1673: exit 0 05:34:45 INFO - TEST-OK | dromaeo_css | took 1113098ms 05:34:45 INFO - TEST-START | kraken 05:34:45 INFO - operating with platform_type : mac_ 05:34:45 INFO - Initialising browser for kraken test... 05:34:45 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmps3_mqG/profile http://localhost:49278/getInfo.html) 05:34:48 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 05:34:48 INFO - PROCESS | 1682 | colorDepth:24 05:34:48 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 05:34:48 INFO - PROCESS | 1682 | __metrics 05:34:48 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:34:48 INFO - TEST-INFO | 1682: exit 0 05:34:48 INFO - Browser initialized. 05:34:48 INFO - Running cycle 1/1 for kraken test... 05:34:48 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmps3_mqG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:00 INFO - PROCESS | 1686 | RSS: Main: 250089472 05:35:00 INFO - PROCESS | 1686 | 05:35:03 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:04 INFO - PROCESS | 1686 | RSS: Main: 261885952 05:35:04 INFO - PROCESS | 1686 | 05:35:07 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:35:07 INFO - PROCESS | 1686 | RSS: Main: 266776576 05:35:07 INFO - PROCESS | 1686 | 05:35:11 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:35:11 INFO - PROCESS | 1686 | RSS: Main: 267055104 05:35:11 INFO - PROCESS | 1686 | 05:35:13 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:35:14 INFO - PROCESS | 1686 | RSS: Main: 268066816 05:35:14 INFO - PROCESS | 1686 | 05:35:16 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:17 INFO - PROCESS | 1686 | RSS: Main: 268607488 05:35:17 INFO - PROCESS | 1686 | 05:35:20 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:20 INFO - PROCESS | 1686 | RSS: Main: 268029952 05:35:20 INFO - PROCESS | 1686 | 05:35:24 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:24 INFO - PROCESS | 1686 | RSS: Main: 269070336 05:35:24 INFO - PROCESS | 1686 | 05:35:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:35:28 INFO - PROCESS | 1686 | RSS: Main: 270704640 05:35:28 INFO - PROCESS | 1686 | 05:35:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:31 INFO - PROCESS | 1686 | RSS: Main: 270417920 05:35:31 INFO - PROCESS | 1686 | 05:35:33 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:33 INFO - PROCESS | 1686 | RSS: Main: 270979072 05:35:33 INFO - PROCESS | 1686 | 05:35:36 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:36 INFO - PROCESS | 1686 | RSS: Main: 270897152 05:35:36 INFO - PROCESS | 1686 | 05:35:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:40 INFO - PROCESS | 1686 | RSS: Main: 271114240 05:35:40 INFO - PROCESS | 1686 | 05:35:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:44 INFO - PROCESS | 1686 | RSS: Main: 271609856 05:35:44 INFO - PROCESS | 1686 | 05:35:45 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:35:46 INFO - PROCESS | 1686 | RSS: Main: 273367040 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | __start_tp_report 05:35:46 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 05:35:46 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 05:35:46 INFO - PROCESS | 1686 | |i|pagename|runs| 05:35:46 INFO - PROCESS | 1686 | |0;ai-astar;112;113;107;115;115;116;109;117;114;115 05:35:46 INFO - PROCESS | 1686 | |1;audio-beat-detection;152;125;143;195;121;164;165;132;208;111 05:35:46 INFO - PROCESS | 1686 | |2;audio-dft;202;199;211;220;197;200;197;199;202;194 05:35:46 INFO - PROCESS | 1686 | |3;audio-fft;71;81;76;172;59;57;53;66;141;81 05:35:46 INFO - PROCESS | 1686 | |4;audio-oscillator;78;84;147;78;83;93;114;112;71;128 05:35:46 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;93;91;93;91;94;115;93;90;94;89 05:35:46 INFO - PROCESS | 1686 | |6;imaging-darkroom;149;106;98;99;98;98;99;127;100;143 05:35:46 INFO - PROCESS | 1686 | |7;imaging-desaturate;140;99;77;98;98;132;120;76;136;92 05:35:46 INFO - PROCESS | 1686 | |8;json-parse-financial;57;61;61;61;59;60;60;119;61;60 05:35:46 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;66;67;72;67;75;76;93;92;74;66 05:35:46 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;78;89;105;98;82;103;104;107;87;87 05:35:46 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;126;161;146;140;126;136;137;136;233;158 05:35:46 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;167;163;215;212;168;164;169;205;167;166 05:35:46 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;69;66;70;81;62;77;82;84;82;86 05:35:46 INFO - PROCESS | 1686 | __end_tp_report 05:35:46 INFO - PROCESS | 1686 | __start_cc_report 05:35:46 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1075 05:35:46 INFO - PROCESS | 1686 | __end_cc_report 05:35:46 INFO - PROCESS | 1686 | __startTimestamp1463488546194__endTimestamp 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | ------- Summary: start ------- 05:35:46 INFO - PROCESS | 1686 | Number of tests: 14 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.16 (2.8%) stddev-sans-first:3.32 05:35:46 INFO - PROCESS | 1686 | Values: 112.0 113.0 107.0 115.0 115.0 116.0 109.0 117.0 114.0 115.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:158.00 stddev:31.88 (20.2%) stddev-sans-first:33.82 05:35:46 INFO - PROCESS | 1686 | Values: 152.0 125.0 143.0 195.0 121.0 164.0 165.0 132.0 208.0 111.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:202.10 Median:201.00 stddev:7.75 (3.9%) stddev-sans-first:8.22 05:35:46 INFO - PROCESS | 1686 | Values: 202.0 199.0 211.0 220.0 197.0 200.0 197.0 199.0 202.0 194.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:85.70 Median:68.50 stddev:39.23 (57.3%) stddev-sans-first:41.25 05:35:46 INFO - PROCESS | 1686 | Values: 71.0 81.0 76.0 172.0 59.0 57.0 53.0 66.0 141.0 81.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:78.00 stddev:25.21 (32.3%) stddev-sans-first:25.60 05:35:46 INFO - PROCESS | 1686 | Values: 78.0 84.0 147.0 78.0 83.0 93.0 114.0 112.0 71.0 128.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:93.00 stddev:7.47 (8.0%) stddev-sans-first:7.91 05:35:46 INFO - PROCESS | 1686 | Values: 93.0 91.0 93.0 91.0 94.0 115.0 93.0 90.0 94.0 89.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:111.70 Median:98.00 stddev:20.17 (20.6%) stddev-sans-first:16.26 05:35:46 INFO - PROCESS | 1686 | Values: 149.0 106.0 98.0 99.0 98.0 98.0 99.0 127.0 100.0 143.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:84.50 stddev:23.65 (28.0%) stddev-sans-first:21.83 05:35:46 INFO - PROCESS | 1686 | Values: 140.0 99.0 77.0 98.0 98.0 132.0 120.0 76.0 136.0 92.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:60.50 stddev:18.70 (30.9%) stddev-sans-first:19.55 05:35:46 INFO - PROCESS | 1686 | Values: 57.0 61.0 61.0 61.0 59.0 60.0 60.0 119.0 61.0 60.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:74.50 stddev:10.08 (13.5%) stddev-sans-first:10.17 05:35:46 INFO - PROCESS | 1686 | Values: 66.0 67.0 72.0 67.0 75.0 76.0 93.0 92.0 74.0 66.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:84.50 stddev:10.59 (12.5%) stddev-sans-first:9.52 05:35:46 INFO - PROCESS | 1686 | Values: 78.0 89.0 105.0 98.0 82.0 103.0 104.0 107.0 87.0 87.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:143.00 stddev:31.45 (22.0%) stddev-sans-first:32.15 05:35:46 INFO - PROCESS | 1686 | Values: 126.0 161.0 146.0 140.0 126.0 136.0 137.0 136.0 233.0 158.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:168.50 stddev:21.64 (12.8%) stddev-sans-first:22.47 05:35:46 INFO - PROCESS | 1686 | Values: 167.0 163.0 215.0 212.0 168.0 164.0 169.0 205.0 167.0 166.0 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:81.50 stddev:8.45 (10.4%) stddev-sans-first:8.59 05:35:46 INFO - PROCESS | 1686 | Values: 69.0 66.0 70.0 81.0 62.0 77.0 82.0 84.0 82.0 86.0 05:35:46 INFO - PROCESS | 1686 | -------- Summary: end -------- 05:35:46 INFO - PROCESS | 1686 | 05:35:46 INFO - TEST-INFO | 1686: exit 0 05:35:47 INFO - TEST-OK | kraken | took 61765ms 05:35:47 INFO - SUITE-END | took 1174s 05:35:47 INFO - Completed test suite (00:19:35) 05:35:47 INFO - javascript benchmark 05:35:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7012.456934553339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3504.7021003214727, 3507.9649203507965, 3528.294341131773, 3548.591911930129, 3571.17862891535, 5862.76548938043, 5934.970325148379, 5945.732442040113, 6044.063170208614, 6051.122587224861, 5760.337561180466, 5881.117832325142, 5910.586258961875, 5916.1125831125355, 6041.305249896263, 5209.348831396075, 5250.763715632786, 5341.584480112773, 5353.973230133844, 5367.329083864517, 870.7587097391263, 5277.076511610472, 5283.55089817366, 5298.973505132469, 5391.083515802323, 4440.844570440036, 5349.144136938091, 5367.597430192751, 5368.812091576776, 5389.946100538984, 5376.811811586615, 5399.325084364455, 5407.270018547524, 5424.701641409721, 5432.2123292122815, 5234.7120908350025, 5253.842384728464, 5274.55166310864, 5315.495027972375, 5368.731563421852, 5668.43315668434, 5858.502027327682, 5883.294004719418, 5888.02847530157, 5950.166976623276, 5925.0, 6252.343503932113, 6270.341614130496, 6271.5923464975085, 6285.59143655661, 5396.64921780083, 6147.9548476759055, 6204.317525072239, 6210.0, 6212.502999760053, 5054.7472626368535, 6000.399960004008, 6013.51891848651, 6017.338092809831, 6058.96970515149, 5130.692158470503, 6403.807885763435, 6404.359564043559, 6406.679666016774, 6413.518986075969, 6183.196184495987, 6221.688915554204, 6236.563440559208, 6280.152179455807, 6284.591501552384, 6205.162303089115, 6254.593451425642, 6277.937220627827, 6279.905801412982, 6297.370262973757, 6137.285055221596, 6154.0, 6214.912390331674, 6245.281792593819, 6250.937490625127, 5321.680699158062, 5943.405659434022, 6148.600340977822, 6242.5942313750365, 6250.874982500324, 4326.913461730748, 4482.439695038121, 4681.063787242497, 5073.315102461194, 5124.590032797368, 4490.281554951257, 4506.819727210875, 4527.071950250191, 4550.180967425829, 4577.839775607904, 5846.1523079153285, 5942.732577034044, 5973.910391344133, 5987.730552125165, 6005.6997150142315, 6254.15568898202, 6275.184226050585, 6276.6547839868335, 6294.0, 6297.0, 5870.14882841994, 5923.496502797224, 5986.431289027535, 6035.486983606443, 6050.878982420327, 5505.284313039279, 5508.614396992252, 5521.861953451115, 5523.392426833045, 5544.944550554524, 6431.903521447182, 6439.9356006440275, 6457.418832305021, 6457.773977910939, 6457.935420645734, 6132.967444181115, 6192.195014648067, 6203.0, 6254.155688981929, 6266.937330626635, 6425.1004859320665, 6438.291787903233, 6450.000249961264, 6462.418382345423, 6478.546501744832, 6251.187345645037, 6256.155419018374, 6257.2491301044165, 6258.780942666985, 6260.0, 6125.815438131457, 6182.598131121463, 6193.318734939063, 6193.752249910133, 6273.874522509615, 5372.5433338166695, 6199.0, 6254.499640028877, 6259.6870156492905, 6271.24745030581, 6180.134781130735, 6258.405451482102, 6267.9373206267355, 6276.152719382825, 6320.083587879823, 4889.853304400732, 5965.343812180743, 6078.756849726138, 6098.847528811638, 6166.876662466815, 5766.019776638065, 5970.134330522137, 6201.0, 6218.81343559694, 6225.128482012612, 5430.13117901134, 6172.85802126608, 6205.6586887721605, 6223.0, 6236.0], "value": 5733.3219440264065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.1061867401329, 512.5591990887837, 516.1947362115101, 516.6280278199695, 544.8748334688864, 38380.353866382684, 41050.38424423629, 41182.79408602953, 41208.793956030175, 41248.175036499255, 41869.79065104678, 42094.57905420945, 42535.78732106343, 42662.0, 42760.0, 9662.468564228964, 9860.60557577696, 9880.654177103803, 9884.11043006133, 9901.257405694565, 9581.281403894702, 9624.855627165563, 9682.612695492171, 9707.029297070307, 9729.173020293283, 9626.278029147841, 9725.27060470464, 9725.610975560969, 9732.978037306088, 9764.316497845119, 9674.661386851461, 9702.611895524242, 9723.367981081243, 9728.854067188999, 9771.657991970247, 9632.133108020313, 9688.90311096894, 9693.563789629483, 9696.36973596721, 9723.951380243125, 39080.0, 39091.21817563633, 39287.21425571472, 39526.81419557418, 39643.0, 2799.594058861474, 3021.3202029543395, 3035.7874948753597, 3358.9664103358896, 3360.865565377382, 25756.742432575622, 26856.0, 27891.581626275623, 28531.714682853115, 28583.28541786451, 2622.1740151852105, 2650.1651979626354, 2692.367293685982, 2720.3063218879256, 2722.1153125234378, 431633.0, 435532.0, 436372.0, 437548.0, 439248.8037559824, 33556.66443335584, 34329.14177145541, 34628.826855866064, 34636.82681586576, 35329.646703532635, 36653.63346366502, 36846.44730329047, 37141.442878356844, 37188.62811371906, 37190.8140459296, 15096.320665570076, 15192.620184495256, 15204.011739236914, 15252.847471525365, 15349.232538373037, 12334.568290109803, 12772.169808962388, 12915.289659068654, 12920.870791292155, 12925.159864608959, 8210.589470526449, 8228.876566851503, 8234.917650823534, 8273.503589784512, 8360.874586881202, 3441.776284541497, 3445.707114895262, 3459.429194182982, 3463.7921724696093, 3471.2536804587135, 923.3444254579324, 983.5672304186136, 990.6334656177261, 1018.6434747838346, 1042.9309957293835, 25896.446213227267, 26194.86902565513, 29474.0, 29814.10557683273, 30098.946536871543, 962.4898803634085, 998.8601595776597, 1040.2354269611828, 1069.454578165126, 1162.616336608917, 15032.248387580796, 15195.240237988057, 15617.921910390376, 15781.921090394475, 15888.76166857498, 655241.0, 669258.0, 669300.0, 671841.0, 672530.0, 59072.0, 60727.0, 60772.0, 60864.39135608587, 60956.695216523636, 1207.4988879615037, 1441.4018182454374, 1473.661057956676, 1486.0934829753842, 1494.5740463967718, 26933.461330772883, 29542.261443464085, 29817.0, 29927.653255603116, 30564.694353056184, 51008.74495627498, 51018.234726479874, 51733.7413312931, 51963.220551690996, 51969.740151299, 587466.0, 594976.0, 599849.0, 600455.0, 601434.0, 26128.0, 26388.604170937066, 26786.59820102739, 27550.035748748698, 28062.43875122527, 38435.80782096072, 45154.322685159095, 46038.39616038503, 46238.53761462343, 47168.820779479414, 36404.453933190496, 37931.051723707125, 38181.618183818915, 38595.421068684554, 38619.80690096531, 36985.0, 37138.814305928296, 37377.43933841049, 37625.2474950494, 38284.85145445641, 31635.84182079075, 37176.81411592925, 37796.43305350367, 38066.80966595149, 38528.42207366948, 29096.854515727286, 31991.360172796878, 33425.49861752027, 34572.481412778325, 35013.47479787856, 24804.875975620005, 24851.627225591994, 24893.87553062223, 25459.872700636377, 25532.74467255378], "value": 18270.12291497951, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7087469339021, 348.6931500279753, 391.7062203347489, 402.1113339519661, 412.0687246822181, 19650.312239071634, 20174.49563760903, 21887.562248755035, 22150.446238844037, 22219.333419997387, 11319.603813866517, 11812.350320732356, 11842.881571184285, 11865.406729663526, 18707.812921870776, 5178.689278643294, 5347.224652425396, 5355.0628639988045, 5359.464053594629, 5374.381946076212, 3820.2168555446065, 5683.090705487123, 5999.190109335249, 6011.5491338149595, 6027.879442411149, 5365.356157261134, 6015.127806468059, 6021.789237376693, 6027.517798576126, 6033.758649654009, 5692.800751973682, 5692.943070569283, 5789.681567513785, 5801.187833703264, 5817.767289308423, 5420.810271640513, 5574.331080270353, 5703.0, 5716.657000579979, 5722.9141562876175, 12584.937075314656, 12853.100282980195, 14271.643208919757, 20217.696734548994, 22831.885840570856, 1952.306931039489, 1985.5234743661563, 2009.577988622391, 2062.391594479632, 2164.296603603819, 7998.960005199995, 9610.855837162448, 9712.61149554017, 9728.41629502225, 9895.653652122213, 1411.4142630808306, 1543.49064808614, 1659.2450435052021, 1720.0797573298225, 1740.704080306351, 107529.0, 117512.41243793727, 118546.0, 131176.0, 132038.33980830034, 11576.0, 11795.41022948849, 11822.645320640395, 11831.88168118325, 11925.986291165349, 15221.391144354102, 15235.466758663393, 15243.695126097417, 15247.542573722805, 15256.771148432783, 8808.075152109064, 8860.0, 8875.600597973107, 8922.955385223033, 8981.550922453851, 8764.430312029697, 8767.605457754416, 8783.516906570072, 8815.823683526294, 8874.068222836639, 4564.908701825945, 4602.516735742765, 4610.3084537319, 4713.387259656222, 4743.0988112258565, 1816.7016158875047, 1878.64305781901, 1887.669657809878, 1889.914953827081, 1996.5407956169872, 748.5733132114642, 933.2300851797295, 955.8279509688323, 999.0259496990376, 1027.342500799489, 19680.991365366852, 20395.388138355574, 20509.2821751241, 20631.0, 20693.482662933548, 862.7756783236404, 926.7822061815468, 926.8795056642593, 966.8549717542285, 967.274544091931, 5614.522765564891, 10479.580816767244, 10960.342379457257, 11008.0, 11036.448177591248, 508844.0, 515839.0, 516919.98480091314, 545324.0, 625133.7486625075, 119305.0, 139497.0, 140739.29630351783, 144300.0, 145882.0, 1031.6131450705984, 1034.182995433599, 1038.7143535527791, 1041.6458404142627, 1061.7717190804015, 17917.0, 18212.089395530435, 18480.445586632424, 18513.81486185121, 19041.00069492683, 37932.81033594815, 44557.0, 52651.94696106133, 52889.47110528845, 53310.0, 79696.0, 80850.59574702088, 80897.19102808897, 81422.59288703519, 81460.370792585, 6262.467690246198, 7302.3792977597495, 7357.816054598464, 7541.43439242048, 7592.924070759222, 8355.665773368997, 11817.527298907948, 12831.743365132832, 12890.871091288967, 13229.536966206137, 8783.165599268059, 8825.426347287406, 9362.578683959102, 9751.707448776548, 11174.217804753589, 9226.308026897876, 11011.944940275247, 11292.491837867152, 11353.318800871644, 11368.261063031207, 5931.881362372815, 9758.609655613696, 10622.256442048982, 11494.597689080842, 11556.0, 7270.127584689871, 7462.552246865205, 7872.72445464406, 7944.699540826374, 8242.0, 10866.456677166268, 11212.27120237182, 11275.041621462267, 11317.71705707364, 11434.256773309708], "value": 9101.398340664346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1597.0417749350388, 1647.7445995870642, 1849.3619701203097, 1908.8759230650007, 1977.090538352358, 8296.377771667134, 8856.15866492683, 8866.157715017063, 9338.346315757892, 9360.625574977, 7932.167122452146, 8939.195472407482, 9011.143941325563, 9174.54127293636, 9251.861222081658, 2400.8319417640773, 2440.0, 2443.8655873926928, 2446.2049833803994, 2448.8040956723507, 2416.8187385946035, 2416.891239894209, 2428.077330614364, 2441.5361081394476, 2454.987725061372, 2392.724836643782, 2418.9758102418928, 2424.066734307287, 2446.2661201639526, 2450.889709963056, 2058.4750888523404, 2386.8806559672034, 2394.0663141374876, 2427.611582146857, 2430.149447693311, 2363.6927199463958, 2365.207655435431, 2386.0813586769045, 2401.7117945846435, 2414.2274472168915, 9080.81838363229, 9104.8634270486, 9164.495952722598, 9218.124278193562, 9233.6306547738, 5442.12925931849, 5586.972065139648, 5605.215269862222, 5606.803761868356, 5610.831675049755, 3577.606463289036, 3601.2797440512004, 3619.7466177367596, 3627.3470775260444, 3664.725145614063, 959.3572306554626, 973.124188230591, 977.9364341317792, 978.6330126202674, 996.3274789517047, 11865.703357416047, 12083.27500349973, 12090.939545302304, 12095.39523023854, 12112.0, 4284.764337961442, 4628.958484341064, 4807.855764327076, 4876.4879687633, 4978.2034874419915, 10328.793424131476, 10341.327813692085, 10346.844797328045, 10358.585656573803, 10366.740831479123, 5469.562435005269, 5499.890002199933, 5569.972150139223, 5570.721463926788, 5604.915926261109, 4308.80610372534, 4563.9087218255445, 4680.578747912636, 5078.568321692624, 5109.718965456861, 4069.2854322937346, 4113.835446582103, 4122.525909520384, 4152.91694166115, 4155.397467367215, 1319.7558451686468, 1320.1551007355301, 1325.840899092115, 1328.5947785925193, 1331.5672406467936, 760.6767123972289, 865.8051938313829, 872.450356275555, 876.1895246896595, 930.02812061396, 5165.0, 5627.240322556402, 5674.319081710221, 5674.943250567441, 5866.853328666817, 860.6901515454431, 970.9611615535441, 1011.4538149399389, 1017.31839667423, 1054.620336678795, 3312.0, 3550.25444656625, 3571.9998400447917, 3662.432322989941, 3681.7422780405113, 11077.446127693584, 11159.497822598003, 11262.7184320391, 11425.257358271685, 11437.885621143681, 11237.438128093563, 11342.319460832376, 11400.657980260605, 11434.94282528582, 11447.25592836463, 8144.0, 8467.788305292417, 8535.487870727777, 8647.221750042401, 8652.653893844301, 4178.582141785919, 4405.29515277554, 4592.770361481846, 5406.243125962447, 5599.384067752625, 9340.439573625605, 10040.899591003996, 10180.847287290548, 10446.216533760151, 10516.158707303244, 10446.270758230858, 10580.84128738085, 10613.363198208132, 10803.351798892092, 10813.351198928089, 7268.600226987566, 7525.736599219001, 7615.809604759704, 7696.7306144284685, 7848.979632647947, 8630.223279904587, 8635.136486351315, 8710.47737135774, 8717.476951382938, 8726.69456569017, 7504.1370242420635, 7723.7682869514, 7742.6128693566225, 7766.378689704697, 7792.337651299703, 7465.3654439371085, 7554.886676699964, 7637.732679356196, 7710.961445192738, 7767.339776119094, 7186.89219661695, 7222.422206223595, 7259.419246460165, 7298.6715597797165, 7314.08573928259, 4486.798094085709, 4566.292224705176, 4698.647601429838, 4722.409698787652, 4775.498572649961, 4632.374629424984, 4667.743274119956, 4723.173444647242, 4768.690035147704, 4792.156668564807], "value": 4645.259934757555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2006542042096, 300.483168949407, 305.05585213763396, 308.6311857330491, 311.49848743522926, 5377.166539186423, 5506.944930550693, 5601.6358936669085, 5651.869626074786, 5717.62776933536, 4423.77881105945, 4471.843485478001, 5484.506394424501, 5553.361363443195, 5602.495775380215, 3500.7549471537004, 3556.421594344106, 3902.9024274393223, 4124.690648201382, 4140.337545992642, 3688.377114069801, 3991.720579559432, 4140.7515549067, 4160.981923766971, 4161.063760653859, 4087.57080506547, 4095.6313931746135, 4102.753834769908, 4108.630223279904, 4141.275276826558, 4119.237940980928, 4121.629053385194, 4121.9587804121875, 4141.378793181017, 4189.07840275139, 3438.9312213755834, 3461.9441070473495, 3561.4835848802036, 3572.356975744365, 3583.4624806279007, 4956.553910148104, 5014.047331007097, 5338.893222135574, 5389.003034438641, 5391.137418013138, 3910.921781564353, 3958.960410395888, 4336.696431249814, 4506.616937560311, 4683.906321873577, 5362.51737343641, 5618.101103823409, 5776.711164441803, 5879.8530036749, 5887.764489420418, 3365.293288409437, 3425.9077526987244, 3788.5453745550435, 3911.784851833148, 3938.940915886264, 4844.394450693663, 5454.809081682122, 6157.7229024694, 6193.253081885439, 6245.968770156165, 3566.32239874423, 3933.056066544009, 3960.32674445345, 3966.155737582038, 4023.396490526386, 3345.765796394278, 3646.08847788053, 3700.5744339400776, 3711.3690672585726, 4015.5181378234797, 4668.276417155346, 4678.485366609671, 4699.801550604574, 4719.551642593948, 4720.811167553259, 5260.710660913686, 5387.838364849061, 5492.880339745191, 5761.798337058183, 5847.239858818326, 1191.5650787462687, 1273.496968697378, 1287.5557932513268, 1321.5440672967811, 1377.2425166158573, 701.6596950479013, 715.4526787007943, 798.9360851131895, 812.4800127918137, 839.7942504086537, 3956.3274243378696, 4261.275583150872, 4561.608709343615, 4619.353290539327, 4632.559906808848, 4380.430544029319, 4586.816527338936, 4979.253112033224, 5117.718525481134, 5166.560842328369, 3951.407288906687, 4077.4903137107863, 4606.963433227497, 4616.746078965622, 4647.744374059459, 2447.3881529617597, 2484.391324125601, 2537.936551586225, 2549.6048112542585, 2723.5506141486435, 4815.759212039454, 4823.539994602778, 5262.500062494057, 5275.127329797867, 5331.1470164773455, 4716.3868697069165, 4756.7145971241835, 5053.216751403538, 5178.533931946067, 5309.7345132743985, 4713.515242698539, 5049.31834202378, 5206.947930520646, 5243.868903277448, 5247.242173871796, 4291.39920411149, 4352.4341835562445, 4855.320255164209, 5064.96168285508, 5109.3613298337705, 4456.5043575597765, 4473.731576105314, 4563.439594050459, 4804.663673542818, 5008.513974403084, 4623.930641040454, 4673.789679464364, 4673.836415725434, 4946.9364086721525, 4986.950130498649, 2831.433713257398, 3060.32672811981, 3369.5619569456794, 3487.47687846825, 3497.4229252173104, 4540.772961351985, 4784.947311591444, 4922.4339200992345, 5112.821051263188, 5503.394626590992, 5390.272313237662, 5799.333076696065, 5883.235179426647, 5926.614770039933, 5931.576421658685, 5526.060569703241, 5549.972250138723, 5849.824505264849, 5871.4715675589405, 5877.207451727264, 4791.401074865642, 4991.201407774739, 4996.775145118551, 5651.095824668198, 5809.30288365382, 5188.896222075613, 5559.694216818114, 5631.98624247623, 5935.851603709769, 5944.613600115978, 5277.944411117715, 5298.231756395378, 5383.838484845461, 5422.62041657096, 5549.724612908688], "value": 3919.7975164925942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9670018149, 642.8328634555015, 680.8229860236339, 718.8993540904274, 750.1972889008756, 14806.777898331533, 14867.141607299074, 15222.314995825187, 15611.297491612877, 15668.529944101667, 12281.631551053482, 12530.874691253084, 14596.197209153519, 14607.853921460783, 14650.047746896444, 712.7434123715484, 902.1384577728254, 902.5487256371814, 921.6728061538158, 924.9398789078689, 922.8292765838307, 930.3115694386173, 931.5249222896338, 933.2533972821716, 935.6771913689801, 952.5427794658533, 968.293146003418, 970.4662435660393, 971.5725080964388, 971.9757006074834, 929.5212965322864, 946.1153821177187, 958.2382006305004, 963.9951800240989, 964.1948972607846, 707.9646017699095, 711.5161690050763, 713.4506430048885, 714.0217901474961, 715.234698872207, 14784.852151478563, 15122.848771512365, 15131.394744210218, 15162.772558411632, 15184.240787960558, 12033.819492707617, 12727.299998500079, 12746.553870614576, 12755.936220318932, 12867.485300587965, 8773.298136149093, 10078.596856125747, 10186.439745813977, 10275.537600807982, 10573.577056917715, 3475.565554305712, 3538.0, 3544.556930383702, 3569.01851990702, 3605.2068544920076, 92196.0, 94017.0, 94556.0, 95258.52370738171, 95916.0, 7845.764627061198, 9102.692072761934, 9314.673986410444, 9469.384490008128, 9612.471314077793, 21162.0, 21287.68068478943, 21387.0, 21476.140954361963, 21688.457788555414, 6235.625862448268, 7494.625268736541, 7494.98817659609, 7575.431842611826, 7626.656800443993, 3834.559025712079, 3905.1018265799025, 3949.308870947573, 3954.0114971257185, 3957.1689945111275, 3443.2941247044296, 3536.398812201932, 3552.520409744703, 3553.626869178751, 3558.430651095812, 630.9747610095636, 633.1958412815699, 637.7162162837585, 648.2156590525423, 650.6421468192475, 512.1396054628186, 514.8558403646985, 548.8518100112947, 557.5734563059262, 573.7045421607876, 8000.6399712011935, 8001.239882211181, 8122.431429799975, 8129.471584347117, 8177.386695997824, 459.81147729430774, 557.90515612346, 571.8541771848152, 576.8463073852296, 596.3231731984229, 3549.804760738184, 3784.7368813171965, 3786.659200671953, 3877.166409222031, 3974.940375894364, 87663.12336876677, 88605.55697221472, 88925.55537222401, 91941.54029229812, 94031.0, 82785.58607206926, 83087.0, 83790.9052273698, 85657.57171214104, 85836.0, 58743.706281468316, 74774.6261268701, 75477.0, 75902.62048689721, 77886.0, 7062.0, 8242.784590610678, 8258.710945116893, 8273.83452330962, 8323.93142765876, 28004.719952800213, 47019.294710580056, 47521.762391187825, 47950.520494796, 48623.0, 51248.71878202925, 65361.67319163374, 67950.0, 68142.65928670524, 68700.96948545876, 10466.0, 10726.67819965371, 11071.667849964513, 11096.389698566656, 11281.984621384116, 10068.144207742424, 11864.169508134348, 11965.102617303563, 12266.141370104007, 12294.20087694297, 10849.67450976472, 11263.09895208365, 11522.53909843597, 11613.535458581562, 11683.824742629038, 11349.10900369963, 11507.827382589436, 11526.423678816192, 11544.076473882238, 11553.0, 10404.323718958547, 11223.0, 11291.43542822872, 11294.491747871201, 11452.599159029394, 9367.716562941363, 9426.24590032782, 9564.4739539326, 9833.0, 10030.699079027641, 9478.620855165716, 9631.518424078628, 9742.75643108928, 9760.707178784647, 9789.65736199258], "value": 6849.333922369293, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 115.0, 115.0, 116.0, 109.0, 117.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 143.0, 195.0, 121.0, 164.0, 165.0, 132.0, 208.0, 111.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 199.0, 211.0, 220.0, 197.0, 200.0, 197.0, 199.0, 202.0, 194.0], "value": 202.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 76.0, 172.0, 59.0, 57.0, 53.0, 66.0, 141.0, 81.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 147.0, 78.0, 83.0, 93.0, 114.0, 112.0, 71.0, 128.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 93.0, 91.0, 94.0, 115.0, 93.0, 90.0, 94.0, 89.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 106.0, 98.0, 99.0, 98.0, 98.0, 99.0, 127.0, 100.0, 143.0], "value": 111.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 99.0, 77.0, 98.0, 98.0, 132.0, 120.0, 76.0, 136.0, 92.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 61.0, 61.0, 59.0, 60.0, 60.0, 119.0, 61.0, 60.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 72.0, 67.0, 75.0, 76.0, 93.0, 92.0, 74.0, 66.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 89.0, 105.0, 98.0, 82.0, 103.0, 104.0, 107.0, 87.0, 87.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 161.0, 146.0, 140.0, 126.0, 136.0, 137.0, 136.0, 233.0, 158.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 215.0, 212.0, 168.0, 164.0, 169.0, 205.0, 167.0, 166.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 70.0, 81.0, 62.0, 77.0, 82.0, 84.0, 82.0, 86.0], "value": 75.9, "unit": "score"}]}]} 05:35:47 INFO - Return code: 0 05:35:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:35:47 ERROR - # TBPL SUCCESS # 05:35:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:47 INFO - 2016-05-17 05:35:47.477 screenresolution[1691:11612] starting screenresolution argv=screenresolution get 05:35:47 INFO - 2016-05-17 05:35:47.480 screenresolution[1691:11612] Display 0: 1600x1200x32@60 05:35:47 INFO - 2016-05-17 05:35:47.485 screenresolution[1692:11615] starting screenresolution argv=screenresolution list 05:35:47 INFO - Available Modes on Display 0 05:35:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:47 INFO - Intel Iris: 05:35:47 INFO - Chipset Model: Intel Iris 05:35:47 INFO - Type: GPU 05:35:47 INFO - Bus: Built-In 05:35:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:47 INFO - Vendor: Intel (0x8086) 05:35:47 INFO - Device ID: 0x0a2e 05:35:47 INFO - Revision ID: 0x0009 05:35:47 INFO - Displays: 05:35:47 INFO - Display: 05:35:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:47 INFO - Display Serial Number: 1600x1200 60 05:35:47 INFO - Main Display: Yes 05:35:47 INFO - Mirror: Off 05:35:47 INFO - Online: Yes 05:35:47 INFO - Rotation: Supported 05:35:47 INFO - Return code: 0 05:35:47 INFO - Running post-action listener: _resource_record_post_action 05:35:47 INFO - ##### 05:35:47 INFO - ##### Finished run-tests step (success) 05:35:47 INFO - ##### 05:35:47 INFO - Running post-run listener: _resource_record_post_run 05:35:47 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 33332736; Write bytes: 700015104; Read time: 211; Write time: 1954 05:35:47 INFO - TinderboxPrint: CPU usage
54.9% 05:35:47 INFO - TinderboxPrint: I/O read bytes / time
33,332,736 / 211 05:35:47 INFO - TinderboxPrint: I/O write bytes / time
700,015,104 / 1,954 05:35:47 INFO - TinderboxPrint: CPU idle
2,186.1 (45.1%) 05:35:47 INFO - TinderboxPrint: CPU system
981.4 (20.3%) 05:35:47 INFO - TinderboxPrint: CPU user
1,678.2 (34.6%) 05:35:47 INFO - TinderboxPrint: Swap in / out
425,148,416 / 0 05:35:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 376361472; Write bytes: 371656704; Read time: 28857; Write time: 766 05:35:47 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 32402944; Write bytes: 299852800; Read time: 199; Write time: 1119 05:35:48 INFO - Running post-run listener: _upload_blobber_files 05:35:48 INFO - Blob upload gear active. 05:35:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:48 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 05:35:48 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:48 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:49 INFO - (blobuploader) - INFO - Done attempting. 05:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:50 INFO - (blobuploader) - INFO - Done attempting. 05:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:53 INFO - (blobuploader) - INFO - Done attempting. 05:35:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:53 INFO - Return code: 0 05:35:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e60b85706bf48d875bd9208ccfb3d1095b7db7aeca3fff14311ac4e69e326ccf922063334026a83719c4cbe4df18fc44149afdd34b98619cf408c3b74a3362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f586a9a15474f812940e962f76bea1e12a5e49346f25cec6c7141f8368cbd3d79f3ca44684c06f8cc628695cb94e91036fdd4c5f59cf7961ca8006c5c27e20e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2667b2905a754127a018d42a60272c995bab3661dff3f1dbc27342f6b767340080df2a913762a8416d2b930016b888f2c2b313364ae3dd7d2e2d4896bc494e"} 05:35:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:53 INFO - Contents: 05:35:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e60b85706bf48d875bd9208ccfb3d1095b7db7aeca3fff14311ac4e69e326ccf922063334026a83719c4cbe4df18fc44149afdd34b98619cf408c3b74a3362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f586a9a15474f812940e962f76bea1e12a5e49346f25cec6c7141f8368cbd3d79f3ca44684c06f8cc628695cb94e91036fdd4c5f59cf7961ca8006c5c27e20e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2667b2905a754127a018d42a60272c995bab3661dff3f1dbc27342f6b767340080df2a913762a8416d2b930016b888f2c2b313364ae3dd7d2e2d4896bc494e"} 05:35:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:53 INFO - Copying logs to upload dir... 05:35:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1417.280358 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 37 secs) (at 2016-05-17 05:35:53.190248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 05:35:53.194018) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e60b85706bf48d875bd9208ccfb3d1095b7db7aeca3fff14311ac4e69e326ccf922063334026a83719c4cbe4df18fc44149afdd34b98619cf408c3b74a3362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f586a9a15474f812940e962f76bea1e12a5e49346f25cec6c7141f8368cbd3d79f3ca44684c06f8cc628695cb94e91036fdd4c5f59cf7961ca8006c5c27e20e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2667b2905a754127a018d42a60272c995bab3661dff3f1dbc27342f6b767340080df2a913762a8416d2b930016b888f2c2b313364ae3dd7d2e2d4896bc494e"} build_url:https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/TTa5VU6PTIOpzVpiwsEoHQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36e60b85706bf48d875bd9208ccfb3d1095b7db7aeca3fff14311ac4e69e326ccf922063334026a83719c4cbe4df18fc44149afdd34b98619cf408c3b74a3362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f586a9a15474f812940e962f76bea1e12a5e49346f25cec6c7141f8368cbd3d79f3ca44684c06f8cc628695cb94e91036fdd4c5f59cf7961ca8006c5c27e20e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2667b2905a754127a018d42a60272c995bab3661dff3f1dbc27342f6b767340080df2a913762a8416d2b930016b888f2c2b313364ae3dd7d2e2d4896bc494e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 05:35:53.223862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:35:53.224217) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OdPu8SIJE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.DacqPdt43s/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005138 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:35:53.273450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 05:35:53.273766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 05:35:53.274128) ========= ========= Total master_lag: 0.24 =========