builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1457709192.54 results: success (0) buildid: 20160310030242 builduid: 8f534ec49a6543cf845c110dea8499bc revision: dd1abe874252e507b825a0a4e1063b0e13578288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:12.544313) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:12.556483) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:12.556855) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005698 basedir: '/builds/slave/test' ========= master_lag: 2.48 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:15.038776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-03-11 07:13:15.039105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-03-11 07:13:34.843010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:34.843264) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.006017 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:35.030035) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:35.030319) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:35.030674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-11 07:13:35.030968) ========= 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.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-03-11 07:13:35-- 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% 170M=0s 2016-03-11 07:13:36 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.554183 ========= master_lag: 8.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-11 07:13:43.857363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:43.857648) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.026744 ========= master_lag: 1.49 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:45.377636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:45.377967) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd1abe874252e507b825a0a4e1063b0e13578288 --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 dd1abe874252e507b825a0a4e1063b0e13578288 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-03-11 07:13:46,604 truncating revision to first 12 chars 2016-03-11 07:13:46,604 Setting DEBUG logging. 2016-03-11 07:13:46,604 attempt 1/10 2016-03-11 07:13:46,604 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd1abe874252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 07:13:47,193 unpacking tar archive at: mozilla-central-dd1abe874252/testing/mozharness/ program finished with exit code 0 elapsedTime=0.843077 ========= master_lag: 1.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:47.451997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:47.452299) ========= echo dd1abe874252e507b825a0a4e1063b0e13578288 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd1abe874252e507b825a0a4e1063b0e13578288'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 dd1abe874252e507b825a0a4e1063b0e13578288 program finished with exit code 0 elapsedTime=0.005978 script_repo_revision: 'dd1abe874252e507b825a0a4e1063b0e13578288' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:47.492940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-11 07:13:47.493221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-11 07:13:51.079299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-11 07:13:51.079592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:13:51 INFO - MultiFileLogger online at 20160311 07:13:51 in /builds/slave/test 07:13:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:13:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:51 INFO - {'append_to_log': False, 07:13:51 INFO - 'base_work_dir': '/builds/slave/test', 07:13:51 INFO - 'blob_upload_branch': 'Firefox', 07:13:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:51 INFO - 'branch': 'Firefox', 07:13:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:51 INFO - 'config_files': ('talos/mac_config.py',), 07:13:51 INFO - 'default_actions': ('clobber', 07:13:51 INFO - 'read-buildbot-config', 07:13:51 INFO - 'download-and-extract', 07:13:51 INFO - 'populate-webroot', 07:13:51 INFO - 'create-virtualenv', 07:13:51 INFO - 'install', 07:13:51 INFO - 'run-tests'), 07:13:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:51 INFO - 'download_minidump_stackwalk': True, 07:13:51 INFO - 'download_symbols': 'ondemand', 07:13:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:51 INFO - 'installer_path': 'installer.exe', 07:13:51 INFO - 'log_level': 'info', 07:13:51 INFO - 'log_name': 'talos', 07:13:51 INFO - 'log_to_console': True, 07:13:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:13:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:13:51 INFO - 'opt_config_files': (), 07:13:51 INFO - 'pip_index': False, 07:13:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:51 INFO - 'cmd': ('bash', 07:13:51 INFO - '-c', 07:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:51 INFO - 'enabled': True, 07:13:51 INFO - 'halt_on_failure': False, 07:13:51 INFO - 'name': 'check_screen_resolution'},), 07:13:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:51 INFO - 'cmd': ('bash', 07:13:51 INFO - '-c', 07:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:51 INFO - 'enabled': True, 07:13:51 INFO - 'halt_on_failure': False, 07:13:51 INFO - 'name': 'check_screen_resolution'},), 07:13:51 INFO - 'run_cmd_checks_enabled': True, 07:13:51 INFO - 'sps_profile': False, 07:13:51 INFO - 'sps_profile_interval': 0, 07:13:51 INFO - 'suite': 'dromaeojs', 07:13:51 INFO - 'system_bits': '32', 07:13:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:51 INFO - 'title': 't-yosemite-r7-0097', 07:13:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:51 INFO - 'use_talos_json': True, 07:13:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:51 INFO - 'work_dir': 'build'} 07:13:51 INFO - ##### 07:13:51 INFO - ##### Running clobber step. 07:13:51 INFO - ##### 07:13:51 INFO - Running pre-action listener: _resource_record_pre_action 07:13:51 INFO - Running main action method: clobber 07:13:51 INFO - rmtree: /builds/slave/test/build 07:13:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - ##### 07:13:53 INFO - ##### Running read-buildbot-config step. 07:13:53 INFO - ##### 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: read_buildbot_config 07:13:53 INFO - Using buildbot properties: 07:13:53 INFO - { 07:13:53 INFO - "project": "", 07:13:53 INFO - "product": "firefox", 07:13:53 INFO - "script_repo_revision": "production", 07:13:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:13:53 INFO - "repository": "", 07:13:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:13:53 INFO - "buildid": "20160310030242", 07:13:53 INFO - "stage_platform": "macosx64", 07:13:53 INFO - "basedir": "/builds/slave/test", 07:13:53 INFO - "nightly_build": "True", 07:13:53 INFO - "buildnumber": 165, 07:13:53 INFO - "slavename": "t-yosemite-r7-0097", 07:13:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:13:53 INFO - "platform": "yosemite_r7", 07:13:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:13:53 INFO - "branch": "mozilla-central", 07:13:53 INFO - "repo_path": "mozilla-central", 07:13:53 INFO - "revision": "dd1abe874252e507b825a0a4e1063b0e13578288", 07:13:53 INFO - "pgo_build": "False", 07:13:53 INFO - "builduid": "8f534ec49a6543cf845c110dea8499bc", 07:13:53 INFO - "slavebuilddir": "test" 07:13:53 INFO - } 07:13:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - ##### 07:13:53 INFO - ##### Running download-and-extract step. 07:13:53 INFO - ##### 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: download_and_extract 07:13:53 INFO - mkdir: /builds/slave/test/build/tests 07:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:53 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:13:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:13:55 INFO - Downloaded 1199 bytes. 07:13:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:55 INFO - Using the following test package requirements: 07:13:55 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:55 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:13:55 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:13:55 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'jsshell-mac.zip'], 07:13:55 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:13:55 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:55 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:13:55 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:13:55 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:13:55 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:55 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:13:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:13:55 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')]} 07:13:55 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:56 INFO - Downloaded 17867590 bytes. 07:13:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:59 INFO - Return code: 0 07:13:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:59 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:14:05 INFO - Downloaded 17867590 bytes. 07:14:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:08 INFO - Return code: 0 07:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:08 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:14:10 INFO - Downloaded 10845161 bytes. 07:14:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:14:10 INFO - Return code: 0 07:14: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')]} 07:14:10 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:14:14 INFO - Downloaded 111132293 bytes. 07:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:14 INFO - mkdir: /builds/slave/test/properties 07:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:14 INFO - Contents: 07:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:14 INFO - Running post-action listener: _resource_record_post_action 07:14:14 INFO - Running post-action listener: set_extra_try_arguments 07:14:14 INFO - ##### 07:14:14 INFO - ##### Running populate-webroot step. 07:14:14 INFO - ##### 07:14:14 INFO - Running pre-action listener: _resource_record_pre_action 07:14:14 INFO - Running main action method: populate_webroot 07:14:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:14 INFO - '--tppagecycles', 07:14:14 INFO - '7'], 07:14:14 INFO - 'tests': ['tsvgm']}}, 07:14:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:14:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:14:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'tests': ['damp', 'tps']}, 07:14:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['damp', 'tps']}, 07:14:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:14:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:14 INFO - 'other': {'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'other_l64': {'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'other_nol64': {'tests': ['a11yr', 07:14:14 INFO - 'ts_paint', 07:14:14 INFO - 'tpaint', 07:14:14 INFO - 'sessionrestore', 07:14:14 INFO - 'sessionrestore_no_auto_restore', 07:14:14 INFO - 'tabpaint']}, 07:14:14 INFO - 'svgr': {'tests': ['tsvgx', 07:14:14 INFO - 'tsvgr_opacity', 07:14:14 INFO - 'tart', 07:14:14 INFO - 'tscrollx', 07:14:14 INFO - 'cart']}, 07:14:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['tsvgx', 07:14:14 INFO - 'tsvgr_opacity', 07:14:14 INFO - 'tart', 07:14:14 INFO - 'tscrollx', 07:14:14 INFO - 'cart']}, 07:14:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'tests': ['tp5o']}, 07:14:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'talos_options': ['--e10s'], 07:14:14 INFO - 'tests': ['tp5o']}, 07:14:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'talos_options': ['--xperf_path', 07:14:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:14 INFO - 'tests': ['tp5n']}, 07:14:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:14 INFO - 'talos_options': ['--e10s', 07:14:14 INFO - '--xperf_path', 07:14:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:14 INFO - 'tests': ['tp5n']}}, 07:14:14 INFO - 'talos.zip': {'path': '', 07:14:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:14 INFO - Running post-action listener: _resource_record_post_action 07:14:14 INFO - ##### 07:14:14 INFO - ##### Running create-virtualenv step. 07:14:14 INFO - ##### 07:14:14 INFO - Running pre-action listener: _resource_record_pre_action 07:14:14 INFO - Running main action method: create_virtualenv 07:14:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:14 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 07:14:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:14 INFO - Using real prefix '/tools/python27' 07:14:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:18 INFO - Installing pip.................done. 07:14:18 INFO - Return code: 0 07:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:18 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')]} 07:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:18 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')]} 07:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:18 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:18 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 07:14:18 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 07:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:18 INFO - 'HOME': '/Users/cltbld', 07:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:18 INFO - 'LOGNAME': 'cltbld', 07:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:18 INFO - 'MOZ_NO_REMOTE': '1', 07:14:18 INFO - 'NO_EM_RESTART': '1', 07:14:18 INFO - 'PAGER': '/bin/cat', 07:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:18 INFO - 'PWD': '/builds/slave/test', 07:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:18 INFO - 'SHELL': '/bin/bash', 07:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:18 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:18 INFO - 'USER': 'cltbld', 07:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:18 INFO - 'XPC_FLAGS': '0x0', 07:14:18 INFO - 'XPC_SERVICE_NAME': '0', 07:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:18 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 07:14:18 INFO - Cleaning up... 07:14:18 INFO - Return code: 0 07:14:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14:18 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')]} 07:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:18 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')]} 07:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:18 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:18 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>=0.7.1'] in /builds/slave/test/build 07:14:18 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>=0.7.1 07:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:18 INFO - 'HOME': '/Users/cltbld', 07:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:18 INFO - 'LOGNAME': 'cltbld', 07:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:18 INFO - 'MOZ_NO_REMOTE': '1', 07:14:18 INFO - 'NO_EM_RESTART': '1', 07:14:18 INFO - 'PAGER': '/bin/cat', 07:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:18 INFO - 'PWD': '/builds/slave/test', 07:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:18 INFO - 'SHELL': '/bin/bash', 07:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:18 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:18 INFO - 'USER': 'cltbld', 07:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:18 INFO - 'XPC_FLAGS': '0x0', 07:14:18 INFO - 'XPC_SERVICE_NAME': '0', 07:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:18 INFO - Downloading/unpacking psutil>=0.7.1 07:14:18 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 07:14:18 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 07:14:18 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 07:14:18 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 07:14:18 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 07:14:18 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 07:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:21 INFO - Installing collected packages: psutil 07:14:21 INFO - Running setup.py install for psutil 07:14:21 INFO - building 'psutil._psutil_osx' extension 07:14:21 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 07:14:22 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 07:14:22 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 07:14:22 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 07:14:22 INFO - building 'psutil._psutil_posix' extension 07:14:22 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 07:14:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:14:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:14:22 INFO - ^ 07:14:22 INFO - 1 warning generated. 07:14:22 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 07:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:23 INFO - Successfully installed psutil 07:14:23 INFO - Cleaning up... 07:14:23 INFO - Return code: 0 07:14:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:23 INFO - 'HOME': '/Users/cltbld', 07:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:23 INFO - 'LOGNAME': 'cltbld', 07:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:23 INFO - 'MOZ_NO_REMOTE': '1', 07:14:23 INFO - 'NO_EM_RESTART': '1', 07:14:23 INFO - 'PAGER': '/bin/cat', 07:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:23 INFO - 'PWD': '/builds/slave/test', 07:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:23 INFO - 'SHELL': '/bin/bash', 07:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:23 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:23 INFO - 'USER': 'cltbld', 07:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:23 INFO - 'XPC_FLAGS': '0x0', 07:14:23 INFO - 'XPC_SERVICE_NAME': '0', 07:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:25 INFO - Installing collected packages: mozsystemmonitor 07:14:25 INFO - Running setup.py install for mozsystemmonitor 07:14:25 INFO - Successfully installed mozsystemmonitor 07:14:25 INFO - Cleaning up... 07:14:26 INFO - Return code: 0 07:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:26 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 07:14:26 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 07:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:26 INFO - 'HOME': '/Users/cltbld', 07:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:26 INFO - 'LOGNAME': 'cltbld', 07:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:26 INFO - 'MOZ_NO_REMOTE': '1', 07:14:26 INFO - 'NO_EM_RESTART': '1', 07:14:26 INFO - 'PAGER': '/bin/cat', 07:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:26 INFO - 'PWD': '/builds/slave/test', 07:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:26 INFO - 'SHELL': '/bin/bash', 07:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:26 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:26 INFO - 'USER': 'cltbld', 07:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:26 INFO - 'XPC_FLAGS': '0x0', 07:14:26 INFO - 'XPC_SERVICE_NAME': '0', 07:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:26 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 07:14:26 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 07:14:26 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 07:14:26 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 07:14:26 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 07:14:26 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 07:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 INFO - Downloading docopt-0.6.1.tar.gz 07:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:29 INFO - Running setup.py install for blobuploader 07:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:30 INFO - Running setup.py install for requests 07:14:30 INFO - Running setup.py install for docopt 07:14:30 INFO - Successfully installed blobuploader requests docopt 07:14:30 INFO - Cleaning up... 07:14:30 INFO - Return code: 0 07:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:30 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:30 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 07:14:30 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 07:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:30 INFO - 'HOME': '/Users/cltbld', 07:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:30 INFO - 'LOGNAME': 'cltbld', 07:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:30 INFO - 'MOZ_NO_REMOTE': '1', 07:14:30 INFO - 'NO_EM_RESTART': '1', 07:14:30 INFO - 'PAGER': '/bin/cat', 07:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:30 INFO - 'PWD': '/builds/slave/test', 07:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:30 INFO - 'SHELL': '/bin/bash', 07:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:30 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:30 INFO - 'USER': 'cltbld', 07:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:30 INFO - 'XPC_FLAGS': '0x0', 07:14:30 INFO - 'XPC_SERVICE_NAME': '0', 07:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3XghfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-PmEQWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7wg2LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-cIIdDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-cdEFMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ly4L7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-vLBbsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FMqsZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-efiIzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-m_v_Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-M7R8yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-P7eJJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CSFsbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-mpVV37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4sofV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-b1YaBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:32 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QQTp2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:32 INFO - Running setup.py install for manifestparser 07:14:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:32 INFO - Running setup.py install for mozcrash 07:14:33 INFO - Running setup.py install for mozdebug 07:14:33 INFO - Running setup.py install for mozdevice 07:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozfile 07:14:33 INFO - Running setup.py install for mozhttpd 07:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozinfo 07:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozInstall 07:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozleak 07:14:34 INFO - Running setup.py install for mozlog 07:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for moznetwork 07:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozprocess 07:14:34 INFO - Running setup.py install for mozprofile 07:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozrunner 07:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozscreenshot 07:14:35 INFO - Running setup.py install for moztest 07:14:35 INFO - Running setup.py install for mozversion 07:14:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:35 INFO - Cleaning up... 07:14:35 INFO - Return code: 0 07:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:35 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:35 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 07:14:35 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 07:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:35 INFO - 'HOME': '/Users/cltbld', 07:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:35 INFO - 'LOGNAME': 'cltbld', 07:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:35 INFO - 'MOZ_NO_REMOTE': '1', 07:14:35 INFO - 'NO_EM_RESTART': '1', 07:14:35 INFO - 'PAGER': '/bin/cat', 07:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:35 INFO - 'PWD': '/builds/slave/test', 07:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:35 INFO - 'SHELL': '/bin/bash', 07:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:35 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:35 INFO - 'USER': 'cltbld', 07:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:35 INFO - 'XPC_FLAGS': '0x0', 07:14:35 INFO - 'XPC_SERVICE_NAME': '0', 07:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-mMnXcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:35 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)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-fO_rjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:35 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)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-unqsf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:35 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)) 07:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-A2Al7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-C_sbtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-rDMYJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ZlxWEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-b0OpZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4WAWVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-djw4a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4dBnuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-rYS8K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-85jQEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-DCJrGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-9GwlXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-0JtILY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-DHtq0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:37 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)) 07:14:37 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)) 07:14:37 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)) 07:14:37 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)) 07:14:37 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)) 07:14:37 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)) 07:14:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:37 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 07:14:37 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 07:14:37 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 07:14:37 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 07:14:37 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 07:14:37 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 07:14:39 INFO - Downloading blessings-1.6.tar.gz 07:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:39 INFO - Installing collected packages: blessings 07:14:39 INFO - Running setup.py install for blessings 07:14:40 INFO - Successfully installed blessings 07:14:40 INFO - Cleaning up... 07:14:40 INFO - Return code: 0 07:14:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:40 INFO - Reading from file tmpfile_stdout 07:14:40 INFO - Current package versions: 07:14:40 INFO - blessings == 1.6 07:14:40 INFO - blobuploader == 1.2.4 07:14:40 INFO - docopt == 0.6.1 07:14:40 INFO - manifestparser == 1.1 07:14:40 INFO - mozInstall == 1.12 07:14:40 INFO - mozcrash == 0.17 07:14:40 INFO - mozdebug == 0.1 07:14:40 INFO - mozdevice == 0.48 07:14:40 INFO - mozfile == 1.2 07:14:40 INFO - mozhttpd == 0.7 07:14:40 INFO - mozinfo == 0.9 07:14:40 INFO - mozleak == 0.1 07:14:40 INFO - mozlog == 3.1 07:14:40 INFO - moznetwork == 0.27 07:14:40 INFO - mozprocess == 0.22 07:14:40 INFO - mozprofile == 0.28 07:14:40 INFO - mozrunner == 6.11 07:14:40 INFO - mozscreenshot == 0.1 07:14:40 INFO - mozsystemmonitor == 0.0 07:14:40 INFO - moztest == 0.7 07:14:40 INFO - mozversion == 1.4 07:14:40 INFO - psutil == 3.1.1 07:14:40 INFO - requests == 1.2.3 07:14:40 INFO - wsgiref == 0.1.2 07:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:40 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:40 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 07:14:40 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 07:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:40 INFO - 'HOME': '/Users/cltbld', 07:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:40 INFO - 'LOGNAME': 'cltbld', 07:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:40 INFO - 'MOZ_NO_REMOTE': '1', 07:14:40 INFO - 'NO_EM_RESTART': '1', 07:14:40 INFO - 'PAGER': '/bin/cat', 07:14:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:40 INFO - 'PWD': '/builds/slave/test', 07:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:40 INFO - 'SHELL': '/bin/bash', 07:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:40 INFO - 'USER': 'cltbld', 07:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:40 INFO - 'XPC_FLAGS': '0x0', 07:14:40 INFO - 'XPC_SERVICE_NAME': '0', 07:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 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)) 07:14:40 INFO - Cleaning up... 07:14:40 INFO - Return code: 0 07:14:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:40 INFO - 'HOME': '/Users/cltbld', 07:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:40 INFO - 'LOGNAME': 'cltbld', 07:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:40 INFO - 'MOZ_NO_REMOTE': '1', 07:14:40 INFO - 'NO_EM_RESTART': '1', 07:14:40 INFO - 'PAGER': '/bin/cat', 07:14:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:40 INFO - 'PWD': '/builds/slave/test', 07:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:40 INFO - 'SHELL': '/bin/bash', 07:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:40 INFO - 'USER': 'cltbld', 07:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:40 INFO - 'XPC_FLAGS': '0x0', 07:14:40 INFO - 'XPC_SERVICE_NAME': '0', 07:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:41 INFO - Downloading/unpacking jsonschema 07:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:43 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:43 INFO - warning: no files found matching '*.txt' 07:14:43 INFO - no previously-included directories found matching 'build' 07:14:43 INFO - no previously-included directories found matching 'dist' 07:14:43 INFO - no previously-included directories found matching '.git*' 07:14:43 INFO - Installing collected packages: jsonschema, functools32 07:14:44 INFO - Running setup.py install for functools32 07:14:44 INFO - warning: no files found matching '*.txt' 07:14:44 INFO - no previously-included directories found matching 'build' 07:14:44 INFO - no previously-included directories found matching 'dist' 07:14:44 INFO - no previously-included directories found matching '.git*' 07:14:44 INFO - Successfully installed jsonschema functools32 07:14:44 INFO - Cleaning up... 07:14:44 INFO - Return code: 0 07:14:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 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 0x10fbeca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f8c8cd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, '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.TTYjnslgsf/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.WahkABkwEU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 07:14:44 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 07:14:44 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 07:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:44 INFO - 'HOME': '/Users/cltbld', 07:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:44 INFO - 'LOGNAME': 'cltbld', 07:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:44 INFO - 'MOZ_NO_REMOTE': '1', 07:14:44 INFO - 'NO_EM_RESTART': '1', 07:14:44 INFO - 'PAGER': '/bin/cat', 07:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:44 INFO - 'PWD': '/builds/slave/test', 07:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:44 INFO - 'SHELL': '/bin/bash', 07:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:14:44 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:44 INFO - 'USER': 'cltbld', 07:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:44 INFO - 'XPC_FLAGS': '0x0', 07:14:44 INFO - 'XPC_SERVICE_NAME': '0', 07:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:44 INFO - Downloading/unpacking flake8 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:47 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 07:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:48 INFO - no previously-included directories found matching 'docs/_build' 07:14:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:48 INFO - Running setup.py install for pep8 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:48 INFO - no previously-included directories found matching 'docs/_build' 07:14:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:48 INFO - Cleaning up... 07:14:48 INFO - Return code: 0 07:14:48 INFO - Running post-action listener: _resource_record_post_action 07:14:48 INFO - Running post-action listener: _start_resource_monitoring 07:14:48 INFO - Starting resource monitoring. 07:14:48 INFO - ##### 07:14:48 INFO - ##### Running install step. 07:14:48 INFO - ##### 07:14:48 INFO - Running pre-action listener: _resource_record_pre_action 07:14:48 INFO - Running main action method: install 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:48 INFO - Reading from file tmpfile_stdout 07:14:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:48 INFO - Reading from file tmpfile_stdout 07:14:48 INFO - Output received: 07:14:48 INFO - Usage: mozinstall [options] installer 07:14:48 INFO - Options: 07:14:48 INFO - -h, --help show this help message and exit 07:14:48 INFO - -d DEST, --destination=DEST 07:14:48 INFO - Directory to install application into. [default: 07:14:48 INFO - "/builds/slave/test"] 07:14:48 INFO - --app=APP Application being installed. [default: firefox] 07:14:48 INFO - mkdir: /builds/slave/test/build/application 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:15:23 INFO - Reading from file tmpfile_stdout 07:15:23 INFO - Output received: 07:15:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 07:15:23 INFO - Running post-action listener: _resource_record_post_action 07:15:23 INFO - ##### 07:15:23 INFO - ##### Running run-tests step. 07:15:23 INFO - ##### 07:15:23 INFO - Running pre-action listener: _resource_record_pre_action 07:15:23 INFO - Running main action method: run_tests 07:15:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:23 INFO - 2016-03-11 07:15:23.192 screenresolution[1651:7766] starting screenresolution argv=screenresolution get 07:15:23 INFO - 2016-03-11 07:15:23.195 screenresolution[1651:7766] Display 0: 1600x1200x32@60 07:15:23 INFO - 2016-03-11 07:15:23.200 screenresolution[1652:7768] starting screenresolution argv=screenresolution list 07:15:23 INFO - Available Modes on Display 0 07:15:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:23 INFO - Intel Iris: 07:15:23 INFO - Chipset Model: Intel Iris 07:15:23 INFO - Type: GPU 07:15:23 INFO - Bus: Built-In 07:15:23 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:23 INFO - Vendor: Intel (0x8086) 07:15:23 INFO - Device ID: 0x0a2e 07:15:23 INFO - Revision ID: 0x0009 07:15:23 INFO - Displays: 07:15:23 INFO - Display: 07:15:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:23 INFO - Display Serial Number: 1600x1200 60 07:15:23 INFO - Main Display: Yes 07:15:23 INFO - Mirror: Off 07:15:23 INFO - Online: Yes 07:15:23 INFO - Rotation: Supported 07:15:23 INFO - Return code: 0 07:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:23 INFO - Python 2.7.3 07:15:23 INFO - Return code: 0 07:15:23 INFO - grabbing minidump binary from tooltool 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:23 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa90d30>, '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 0x10f8b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa87b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:23 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 07:15:23 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 07:15:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:23 INFO - Return code: 0 07:15:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:15:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:15:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:24 INFO - Return code: 0 07:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TTYjnslgsf/Render', 07:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:24 INFO - 'HOME': '/Users/cltbld', 07:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:24 INFO - 'LOGNAME': 'cltbld', 07:15:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:24 INFO - 'MOZ_NO_REMOTE': '1', 07:15:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:24 INFO - 'NO_EM_RESTART': '1', 07:15:24 INFO - 'PAGER': '/bin/cat', 07:15:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:24 INFO - 'PWD': '/builds/slave/test', 07:15:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:24 INFO - 'SHELL': '/bin/bash', 07:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WahkABkwEU/Listeners', 07:15:24 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 07:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:24 INFO - 'USER': 'cltbld', 07:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:24 INFO - 'XPC_FLAGS': '0x0', 07:15:24 INFO - 'XPC_SERVICE_NAME': '0', 07:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:15:25 INFO - mozversion application_buildid: 20160310030242 07:15:25 INFO - mozversion application_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 07:15:25 INFO - mozversion application_display_name: Nightly 07:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:25 INFO - mozversion application_name: Firefox 07:15:25 INFO - mozversion application_remotingname: firefox 07:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:25 INFO - mozversion application_vendor: Mozilla 07:15:25 INFO - mozversion application_version: 48.0a1 07:15:25 INFO - mozversion platform_buildid: 20160310030242 07:15:25 INFO - mozversion platform_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 07:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:25 INFO - mozversion platform_version: 48.0a1 07:15:25 INFO - using testdate: 1457709325 07:15:25 INFO - actual date: 1457709325 07:15:25 INFO - starting webserver on 'localhost:49273' 07:15:25 INFO - SUITE-START | Running 2 tests 07:15:25 INFO - TEST-START | dromaeo_css 07:15:25 INFO - operating with platform_type : mac_ 07:15:25 INFO - Initialising browser for dromaeo_css test... 07:15:25 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp7kmEDX/profile http://localhost:49273/getInfo.html) 07:15:27 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 07:15:27 INFO - PROCESS | 1670 | colorDepth:24 07:15:27 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 07:15:27 INFO - PROCESS | 1670 | __metrics 07:15:27 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:27 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:28 INFO - TEST-INFO | 1670: exit 0 07:15:28 INFO - Browser initialized. 07:15:28 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:28 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp7kmEDX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:40 INFO - PROCESS | 1674 | RSS: Main: 243236864 07:15:40 INFO - PROCESS | 1674 | 07:16:31 INFO - PROCESS | 1674 | 1457709391491 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] 07:18:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 07:18:43 INFO - PROCESS | 1674 | RSS: Main: 381382656 07:18:43 INFO - PROCESS | 1674 | 07:21:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 07:21:46 INFO - PROCESS | 1674 | RSS: Main: 381149184 07:21:46 INFO - PROCESS | 1674 | 07:24:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 07:24:49 INFO - PROCESS | 1674 | RSS: Main: 377171968 07:24:49 INFO - PROCESS | 1674 | 07:27:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 07:27:51 INFO - PROCESS | 1674 | RSS: Main: 330293248 07:27:51 INFO - PROCESS | 1674 | 07:30:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 07:30:55 INFO - PROCESS | 1674 | RSS: Main: 333934592 07:30:55 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 07:33:58 INFO - PROCESS | 1674 | RSS: Main: 421117952 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | __start_tp_report 07:33:58 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 07:33:58 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 07:33:58 INFO - PROCESS | 1674 | |i|pagename|runs| 07:33:58 INFO - PROCESS | 1674 | |0;dojo.html;3387.390269751445;3449.8270588000105;3454.7754395964243;3484.268303656233;3513.5081088647594;5487.807926722566;5610.859728506789;5618.353889302732;5618.438156184385;5668.093105103184;5587.804426845061;5613.186088017245;5629.690367029812;5723.341815691197;5755.1942728018;5010.448850626428;5049.9747501262445;5058.924116138261;5075.111855425286;5186.988537235241;5162.896742065156;5173.922391164117;5197.740112994354;5224.712640804754;5248.763805628737;5003.1994880819075;5017.8243761468175;5096.643234973553;5104.9744751276;5143.254228136899;5125.974370128126;5140.33175687162;5154.742262886841;5159.251908473288;5165.974170129125;5006.799728010911;5064.848054558369;5086.033653605803;5102.897942041175;5103.948960510422;5468.125099984023;5495.890082198373;5558.555315574744;5589.580781441408;5600.831975040755;6060.816715659019;6092.02527595587;6104.175936248638;6104.96947515264;6108.053251745987;6135.601185922946;6178.474829639486;6194.070889366586;6201.379862013762;6212.099245609406;5569.721513924287;5624.746886390122;5659.43405659439;5662.37713851476;5672.950504156703;6270.655113968684;6325.683715814283;6327.335629758809;6330.461910737639;6342.175517182829;5922;5930.673812940244;5990.430909063632;5999.430054144849;6019.187409699634;5504.036793561111;6058.454739073504;6128.869808884179;6160.8767824643255;6173.228346456693;5361.605982444593;5746.511546518593;5764.654120752684;6082.361352058058;6129.049997250344;6069.089636554552;6079.908801367983;6080.878382432326;6086.513078953673;6098.69506524672;4716.740579268173;4800.975995120002;4801.879953001203;4808.735519546389;4821.975890120527;4343.04453020335;4347.826086956549;4413.977930110329;4414.690971631955;4415.094905544356;5547.33431988164;5561.249231353715;5574.972125139429;5588.497035266845;5588.888222235614;6085.148079268906;6100.581173165827;6126.8230438726505;6131.407250743292;6148.1699970503405;5583.944160558342;5598.412166722435;5604.4395560444445;5612.1581762735095;5627.943720562742;5252.369715634149;5259.421463638997;5265.4997775211295;5269.499397557226;5316.494932981361;6185.165002724574;6222.377762223832;6263.279722831932;6310.589811662319;6317.115603815561;6059.272887253558;6064.332923378513;6067.089936509559;6075.161351273365;6090.786822461193;6228.813135605939;6306.180196574416;6311.810645680637;6334.588251763621;6341.968290158519;6027.728752206249;6095.207623008981;6096.847578810565;6100.6949652516305;6128.8774224516155;6127.2514248266525;6161.322254552086;6162.506999440124;6186.907196391968;6196.442320191204;5776.942230577641;5925.111233315038;5950.19672344228;5957.434043765836;5990.34106248321;5695.088785794419;5919.112133179885;5919.289685237799;5932.940670593239;5963.373845746134;5762.711864406847;5782.074868021096;5810.244668193277;5811.854703632443;5818.301803783573;5731.799387021434;5899.115132730125;5954.553408494467;5976.611520251344;5990.6705131218205;5816.94183058164;5820.214271073351;5822.94177058224;5836.766529338779;5843.795467158629 07:33:58 INFO - PROCESS | 1674 | |1;ext.html;492.76839885253963;576.7491141353512;577.6014549960527;633.6704913445009;637;38851.61148388515;39515.80242098793;39544.60455395449;39565.813025609204;39599.40600890989;42659;42984.570154298446;43062.354064688974;43214.567854321445;43313.78343108288;9604.087611676898;9807.803843923117;9835;9841.311108222428;9845.852312215322;9664.516774161299;9802.166815820628;9815.90184098157;9819.901800982007;9840.753981150458;9904;9981.90018099817;9982.90017099827;9995.350302230368;10008.899911000906;9887.802243955117;9961.65134220306;9966.20270378368;9967.05312995268;9988.400695958266;9749.658761943369;9862.45756483393;9871.40771553702;9881.209503239796;9892.80214395708;42150.78924605388;42759.35860962088;42826.143477130594;42848.357274640905;42854;3238.2875767331147;3297.406466835969;3742.5883152853166;3970.8808735737975;4009;28612.570811437847;29546.40907181866;29989.850050749825;30109.849450752827;30140.397192056254;2782.8052036357262;2845.47358738634;2854.343500994783;2857.4427986542632;2866.65600127986;378700;381838;381962.0901895501;382376;382475;66445.66777166084;66889.99665005029;67000;67085.66457167683;67143.66428167828;72100.59245556605;72254;72294.2770572298;72324;72389;17551.91224043897;17793.644127117386;17813;17827.0195139266;17867.463976080737;13441.663958401119;13462;13474.191548506926;13483.865161348458;13508.797368039488;19796.426464559514;20812.687809682866;21011.78988210129;21075;21143.25998590042;6471.932131198394;8873.245774109144;8918.955405222932;9085.640051963652;9242.214411775074;960.4621412009298;1014.6905193915926;1069.2675517270695;1130.1691260158595;1143.2568830260398;28624.690964191854;29160.854195728887;29643.25891852678;30073.849630752145;30097.398052038836;1148.7013376522164;1152.4813833774836;1177.3112729053428;1196.9401529923468;1203.296071798008;11967.162298639187;14258;14778.187199703905;14945;15147.621309467351;490858;510122;517550;517552;517822;59193;59453.40546594565;59551.808963820484;59603.40396596065;59666.80666386735;1329.7473480038761;1448.3265281644085;1482.7331080405415;1489.4935721854404;1557.9298931548108;24775.38061548476;28658.426831463672;28831.279218018877;29505.819767209072;29656.703432965394;46971.53028469672;47224.29163562618;47598.76200618975;47712.761436192595;47737;287442;346874;348779;348780;348975;28699.85200591953;33186.83406582951;33750.324993500486;34267.82866085654;34296.31407371889;42099.57900420957;42726.35910461408;42900.57099428966;43181.784091079346;44046;35381;35646.465303019955;35831;36074.63925360713;36550.90347289586;32225.35549289048;34813.82593087018;35303.64696353004;35701.64298356983;36919.44620830636;35661.64338356583;35833.46249806307;36513;36589.902302930954;36817.63182368142;26477.742822462627;31513.8424307877;31845;32228.516572250966;32239.194020149684;23838;23919.760802392448;24249.51500970006;24365.269041928063;24423.38941526476 07:33:58 INFO - PROCESS | 1674 | |2;jquery.html;351.35526309222575;351.5675718865795;354.42052244580105;361.095455883013;362.98548058077677;19546.92491912946;19621.411357659275;20720.378388648325;20734.377968660945;20746.377608671763;20233.898830505863;20892.686609700828;21086.472838179052;21276.787232127714;21295.467613309676;5735.2544169257935;6003.849903752397;6072.05883088122;6072.544559158058;6074.149619053336;4091.2226676931286;4367.650587952956;5859.355470898197;6526.836829079287;6544.640044797534;6440.484761219114;6478;6479.8056058318325;6480.092787009822;6486.708098135595;5350.571954243651;5609.775608975677;5614.522765564931;5640.943590564103;6447.387498187664;3753.962460375416;5380.946190538084;5501.504864562168;5744.167095771131;5752.223449834302;13178.143420677721;13193;13390.665233369145;13398.665033374145;13429.127106738031;2107.673310636854;2113.186423227053;2196.2422964077527;2219.655953327237;2706.945861082787;9654.324197306192;9832.31173817833;9866.260030497742;10074.949625251827;10186.847197292047;1709.5896984723577;1775.5199808375598;1781.5278951077846;1818.4544636609096;1968.3996381103757;105458;105609;108124.42223610164;110235.44882275537;110256;9689.515524223902;11034.889651103547;11199.496022678999;11262.549498019987;11375.601853935239;13530.729385412236;13548.322583870768;13562.914966802633;13571.389287482087;13601.591952241251;7348.338649521569;8051.194880512019;8429;8609.225169734755;8669.523176225368;8807.383483156245;8818.559072046372;8840.823183536422;8905.064968178378;8915.465072095565;4062.1672557125717;4073.4113695658716;4360.018995725936;4440.578145076212;4488.214562451558;1562.9765553516706;1846.6122114356135;1852.990735046316;1856.5544269375523;1868.215349553191;824.6330382979517;846.6571038729325;850.9829803403898;858.888344515209;892.8035832116924;14831.480898168513;17724.91137544304;17854.732179017326;18170.54573635643;18519.074046297632;872.8647059705755;899.7030979776658;905.3798148268457;905.4929239625831;907.7095329494631;9447.480388578695;9683.806323873483;9704.126628603319;9780.070893265129;9829;617965;622224;626423;628936;637688;82992.58503707443;93937;116989;119782;120815;990.2721499697716;1000.9949950250202;1011.1506334678905;1023.467796745688;1024.08856118055;15713.68572628564;15975.360985560448;17940.641187176443;17948.83332583378;18177.909110454362;50518.98962020665;50802;51353;51940;52075.47924520858;76019.23980760343;77156;77264;77518.61240693761;78916;7725.768226953201;7807.882881756665;7980.880286795818;7997.480163789335;8209.917900820916;9927;12372.505099795908;12471.625851224479;12482.937585312015;12887.806682899576;7292.34368906801;10331.586736530455;10557.102646275152;10794.280107385057;10951.137635210742;8088.150744171778;10369.429681367597;10411.791764164826;10619.893801061891;10753.354798712102;10049.296549241775;10539.209559283237;10976.890231097586;11681.766364672489;11803.527858885549;6368.395002474757;7748.9612551939135;7889.605519724106;7912.536180806569;8130.593470326342;8004.679812807422;9848.867380251362;11196.776064478501;11266.211365204357;11271.154663400443 07:33:58 INFO - PROCESS | 1674 | |3;mootools.html;1272.8790764877344;1580.7154712151812;1603.4067395063823;1880.9905950470245;2025.6455120353935;7439;7876.763697089083;8045.557494337809;8267.214614611617;8837.513936733478;8501.829963400729;8602.35482338824;8641.740747777561;8642.135786421355;8794.648214071429;2197.088208393515;2250.3024062540667;2251.966220506694;2477.2568229531157;2509.0841842727455;2274.3859158027403;2467.358486793438;2537.974620253792;2539.898404063835;2543.2370288913253;2436.3543660929868;2470.950580988379;2471.5798314286612;2479.219046000513;2480.6651102101164;2155.9651367343604;2459.913903013386;2460.495598402323;2476.0590975429313;2489.240781561623;2465.285067330472;2490.2653717153485;2498.650188973545;2500.6874140732407;2507.711613164473;8900.109989001114;8970.641174353019;9005.819883602291;9006.279497640238;9010.954945225298;5446.972765136188;5542.889142217133;5552.222688823568;5604.299462567179;5613.859653508654;3511.5610548681416;3541.557305336833;3694.6305369463107;3707.5921648618632;3724.5902950675404;1032.1278519650957;1038.3302769713569;1056.5351245451977;1057.7937302226069;1061.7929503746773;11990.760184796256;12005.339706316148;12025.63923082309;12042;12068.758624827542;4881.536254055859;4974.875628109254;5004.84985450437;5034.144195486776;5048.924266136011;10219.846702299472;10306.227032972558;10316.845247321296;10323.32898361604;10349.482525873676;5556.361018482926;5594.1888426177975;5604.103343465107;5604.299462567179;5606.243157173811;4474.7762611869275;4531.071130418256;5075.314832497639;5081.949180508222;5085.0084233574835;3955.6835453163676;3955.782431966212;4029.8992525187105;4033.576474470197;4043.1913617276664;1286.6075846866795;1347.905646604748;1353.0799056641579;1362.6729584899751;1365.9795103073461;1183.0476466444595;1191.576990168495;1199.8560172779148;1392.4499822570028;1431.720814441174;8092.7167549136675;8110.472819266729;8154.6738130475305;8159.67361305553;8189.71336003249;1202.7955247607927;1213.83006379107;1219.4878151176526;1222.8715984821465;1233.426456697622;6374.266959299647;6376.458001069868;6454.935450645434;6463.450606698483;6469.935300646934;10347.534360953776;10735;10861.34831910088;10875.238733288752;10917;8613;10504.212184086224;10512.632057877938;10707.785844283071;10744.355338679705;8315.210055044761;8374.916250837414;8422.24199822019;8470.788230294169;8481.660733570712;7799.869018992328;7904.051513818378;7944.523328600302;7961.562114083781;7994.2405471480115;9265.305102117234;9539.379940303857;9657.179139773198;9666.226701863694;9734.172595329477;9648.903510965081;9972.00279971997;10051;10085.041921017491;10093;7345.412367010733;7530.6611202497115;7588.241175882367;7589.810254743676;7602.7339043133225;8328.292095171735;8333.708320208763;8373.62318695648;8380.12008739098;8393.118722534045;7384.37232835215;7459.813504662427;7464.552126872405;7590.886136707843;7615.619219039137;6743.325667433413;7068.257832927674;7354.880445871008;7460.440466964891;7520.473566850268;7773;7827.334676552557;7847;7847.646855891385;7849.529028258323;5911.822645320647;7116.110486189226;7179.641017948978;7182.425405967615;7189.460790440842;7244.855102897807;7299.05112335393;7302.56184628924;7314.378277846443;7315.743948961761 07:33:58 INFO - PROCESS | 1674 | |4;prototype.html;319.7122589669297;323.5211886408116;324.95195070241135;327.1804130652715;329.8845404108564;6413.518986076046;6415.45468635166;6515.31589183136;6515.8371040724005;6536.967315163418;6367.617942923416;6396.424321811036;6399.488040956724;6429.067785171147;6446.903296450545;3750.306193354238;4561;4624.907501849961;4702.97648511757;4787.186178349681;4714.080754252922;4717.858464246078;4732.526747325274;4749.928751068719;4772.236442169236;3815.5421349437966;4716.033213191287;4722.8110875564935;4727.645426593002;4746.382970213867;3838.4242363645535;4538.364628951933;4623.768811559408;4716.245400735866;4728.432588089417;4093.5497095319492;4100.979495102535;4102.384642303648;4104.281750693646;4120.196561670476;5414.377346605152;5668.809549994506;6206.069089636546;6209.316975132777;6218.347073557302;4592.173408786417;5608.233406476947;5615.0454422748235;5615.6630602164005;5622.32532096151;6853.348931851466;6868.965655171743;6871.244163142051;6880.174379074493;6881.208661003999;4425.15921974827;4605.37827393301;4614.330922016289;4616.792244349012;4639.837605683819;6300.495960323209;7094.893576596355;7197.172325182619;7285.198628150899;7310.550965426589;4567.10941366437;4718.339432479455;4719.10337035962;4725.1730947084125;4728.692634978715;4780.259059845729;4785.042991401733;4790.8323208687525;4803.3995750531185;4812.711237325701;4592.609628181575;5621.634593751393;5627.6904770237215;5632.3804381518;5634.408387119293;6583.341665833378;6638.249389095242;6949.339812717783;6967.825804354931;6973.930260697328;1388.8680575345327;1635.8200597934217;1657.3867668962562;1669.2071266148725;1675.7570152327844;931.8602209668604;1092.1426680056118;1097.0181687389902;1110.2339385823757;1118.278710231896;6229.283632382243;6313.337099604567;6429.710663020175;6524.217093948661;6570.638614876228;7271.1279044778075;7271.854562908818;7274.381677557361;7292.052033235752;7306.977023216754;6495.350464953467;6508.121403610452;6515.283318834924;6522.21733391996;6541.2150541934325;3426.8629254830025;3835.079580900564;3841.2893614681375;3845.1540661054523;3849.4610754494392;7216.386607138347;7567.0703970487175;7574.242575742492;7581.203973582695;7587.734429294948;5732.996725573008;6645.800625981228;7395.741149059757;7419.85160296791;7422.294881986203;6117.235345581802;7543.0948286206;7558.470907036454;7559.697612095454;7566.659500322498;7190.245024272376;7194.136703595393;7195.568265904062;7208.243134470805;7209.855802884018;6796.320367963164;7076.221615622175;7093.964530177316;7108;7114.893276600752;7413.629318534159;7542.6605802740105;7548.8676698495665;7560.054993125859;7570.621468926642;4483.170613436394;4536.251518499411;4551.590356867898;4553.180427522945;4556.567126123013;5792.652440853562;7100.644967751695;7128.536645118258;7134.643267836691;7214.386777123793;6532.314107018885;6873.793786186422;6876.587404755731;6907.6891539881835;6927.653617319214;5609;6812.182538095461;6864.313568643096;6874.759383421556;6882.655867206719;5333.759980800795;6728.932710673026;6763.613459240745;6764.93235067643;6781.220159681699;5594.636348637326;6903.309669033057;6908.860038093659;6914;6918.169819621678;5202.869928251824;6077.848053798691;6600.372964568358;6604.504662150454;6749.696263668245 07:33:58 INFO - PROCESS | 1674 | |5;yui.html;642.8617847162859;705.2594775485742;728.4136270302411;730.9195988441271;766.1763604125565;15001.324940377683;15219.84780152198;15233.933624646279;15234.390624375039;15287.235638218086;10987.780244395108;13876.791848122286;14219.14685118891;14298.642533936656;14335.64160895978;749.6401727170961;759.3128218961848;903.2999425445266;907.8320510705507;924.3483344242293;934.243262957007;935.8502639577669;936.6862101196108;938.9952750556907;940.6895724410928;980.6126580000895;987.4075554667214;988.3625061835112;990.044606954289;993.1161266472845;781.3436713160944;943.3208090175063;981.2738573455663;982.3172894838091;985.093713783321;726.5749536521141;726.8073960400445;728.0317178153043;730.1894896664697;730.3974221267423;15080.698386032218;15147.091174529563;15185.848141518554;15190.772138417933;15218.771718424232;12569.937150314281;12624.873751262461;12635.43140558677;12641.2415255085;12889.806652900214;10050.69847904564;10209.591616335338;10294.279400441972;10412.531436085394;10902.96421839924;3517.99574813421;3522.101864024683;3553.6979356754705;3616.258218768695;3636.272745450894;77598;78065;80461.59769201175;81134;81166.59416702938;9616.855747163798;9714.072042876729;9734.02659734021;9847.950760246153;10024.899751002396;18300.17649205789;22583.774162258494;22615.982280797405;22620.886895565418;22623.868806559607;7748.263914928186;7802.882956755653;7875.173106823701;7963.362930965509;7979.0425148982495;4154.646855017358;4155;4161.209370219649;4238.321868501025;4287.035417031206;3153.369326134782;3713.7400381973002;3752.2307926874923;3754.8685795997553;3757.04195430169;486.8125771577968;628.2084573437411;648.614074625597;653.1509038250256;660.2769966886252;544.9291592093002;606.7239406070228;612.3325575123138;618.1809102938535;624.1698540940538;7852.450328477066;8249.587520623945;8285.50286982783;8341.165883411732;8561.657533698706;530.6736357140331;593.6813214133017;598.0795882987062;602.7679343452802;620.9472194863397;3871.2064026874423;3886.358750806142;3887.1642596841248;3945.447637330776;4078.1435898461655;74582.25417745861;78387.216127838;87786;91184.54407727919;92200.53899730458;65122.674386628714;76653.61673191599;77038.22961770311;77599.61200193963;78285;68201.65899170472;68866.65566672134;69714.91984463636;70428;70452;6699.330066993261;7407.925920740724;7705.961470192613;7809.1409944907155;7821.648025838737;47790.80522986953;49521;52893.20660190023;56278;58472.106265653594;67747.3225267741;68187.65906170437;69265.72709865593;69344.6532767333;71389.5722085545;11739.943405093583;11937.701557461132;11975.341356225492;12026.939865300617;12533.874661253636;11625.18623696333;11748.941255293668;12135.453904574491;12511.249325040526;13065.542706005244;11083.279586826831;11404.48679809427;11525.366104864313;11852.940735296268;11922.165448418527;11703.707407314885;11970.281783093042;12374.195677280948;12379.195352302071;12502;11527.077833773446;11564;11807.23252988553;11912.225705329125;12506.499740010298;9270.119338662817;9554.570044347882;9708.563114659715;9818.45998470091;10251.333663311862;8560.493323312743;8719.607617657093;9111.043340449158;9264.95367523158;9369.297302702189 07:33:58 INFO - PROCESS | 1674 | __end_tp_report 07:33:58 INFO - PROCESS | 1674 | __start_cc_report 07:33:58 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1249 07:33:58 INFO - PROCESS | 1674 | __end_cc_report 07:33:58 INFO - PROCESS | 1674 | __startTimestamp1457710438704__endTimestamp 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | ------- Summary: start ------- 07:33:58 INFO - PROCESS | 1674 | Number of tests: 6 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5634.21 Median:5776.94 stddev:610.58 (10.6%) stddev-sans-first:586.46 07:33:58 INFO - PROCESS | 1674 | Values: 3387.4 3449.8 3454.8 3484.3 3513.5 5487.8 5610.9 5618.4 5618.4 5668.1 5587.8 5613.2 5629.7 5723.3 5755.2 5010.4 5050.0 5058.9 5075.1 5187.0 5162.9 5173.9 5197.7 5224.7 5248.8 5003.2 5017.8 5096.6 5105.0 5143.3 5126.0 5140.3 5154.7 5159.3 5166.0 5006.8 5064.8 5086.0 5102.9 5103.9 5468.1 5495.9 5558.6 5589.6 5600.8 6060.8 6092.0 6104.2 6105.0 6108.1 6135.6 6178.5 6194.1 6201.4 6212.1 5569.7 5624.7 5659.4 5662.4 5673.0 6270.7 6325.7 6327.3 6330.5 6342.2 5922.0 5930.7 5990.4 5999.4 6019.2 5504.0 6058.5 6128.9 6160.9 6173.2 5361.6 5746.5 5764.7 6082.4 6129.0 6069.1 6079.9 6080.9 6086.5 6098.7 4716.7 4801.0 4801.9 4808.7 4822.0 4343.0 4347.8 4414.0 4414.7 4415.1 5547.3 5561.2 5575.0 5588.5 5588.9 6085.1 6100.6 6126.8 6131.4 6148.2 5583.9 5598.4 5604.4 5612.2 5627.9 5252.4 5259.4 5265.5 5269.5 5316.5 6185.2 6222.4 6263.3 6310.6 6317.1 6059.3 6064.3 6067.1 6075.2 6090.8 6228.8 6306.2 6311.8 6334.6 6342.0 6027.7 6095.2 6096.8 6100.7 6128.9 6127.3 6161.3 6162.5 6186.9 6196.4 5776.9 5925.1 5950.2 5957.4 5990.3 5695.1 5919.1 5919.3 5932.9 5963.4 5762.7 5782.1 5810.2 5811.9 5818.3 5731.8 5899.1 5954.6 5976.6 5990.7 5816.9 5820.2 5822.9 5836.8 5843.8 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:57224.77 Median:36868.54 stddev:110299.77 (299.2%) stddev-sans-first:110526.94 07:33:58 INFO - PROCESS | 1674 | Values: 492.8 576.7 577.6 633.7 637.0 38851.6 39515.8 39544.6 39565.8 39599.4 42659.0 42984.6 43062.4 43214.6 43313.8 9604.1 9807.8 9835.0 9841.3 9845.9 9664.5 9802.2 9815.9 9819.9 9840.8 9904.0 9981.9 9982.9 9995.4 10008.9 9887.8 9961.7 9966.2 9967.1 9988.4 9749.7 9862.5 9871.4 9881.2 9892.8 42150.8 42759.4 42826.1 42848.4 42854.0 3238.3 3297.4 3742.6 3970.9 4009.0 28612.6 29546.4 29989.9 30109.8 30140.4 2782.8 2845.5 2854.3 2857.4 2866.7 378700.0 381838.0 381962.1 382376.0 382475.0 66445.7 66890.0 67000.0 67085.7 67143.7 72100.6 72254.0 72294.3 72324.0 72389.0 17551.9 17793.6 17813.0 17827.0 17867.5 13441.7 13462.0 13474.2 13483.9 13508.8 19796.4 20812.7 21011.8 21075.0 21143.3 6471.9 8873.2 8919.0 9085.6 9242.2 960.5 1014.7 1069.3 1130.2 1143.3 28624.7 29160.9 29643.3 30073.8 30097.4 1148.7 1152.5 1177.3 1196.9 1203.3 11967.2 14258.0 14778.2 14945.0 15147.6 490858.0 510122.0 517550.0 517552.0 517822.0 59193.0 59453.4 59551.8 59603.4 59666.8 1329.7 1448.3 1482.7 1489.5 1557.9 24775.4 28658.4 28831.3 29505.8 29656.7 46971.5 47224.3 47598.8 47712.8 47737.0 287442.0 346874.0 348779.0 348780.0 348975.0 28699.9 33186.8 33750.3 34267.8 34296.3 42099.6 42726.4 42900.6 43181.8 44046.0 35381.0 35646.5 35831.0 36074.6 36550.9 32225.4 34813.8 35303.6 35701.6 36919.4 35661.6 35833.5 36513.0 36589.9 36817.6 26477.7 31513.8 31845.0 32228.5 32239.2 23838.0 23919.8 24249.5 24365.3 24423.4 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:34211.48 Median:4082.32 stddev:103798.88 (2542.6%) stddev-sans-first:104058.92 07:33:58 INFO - PROCESS | 1674 | Values: 351.4 351.6 354.4 361.1 363.0 19546.9 19621.4 20720.4 20734.4 20746.4 20233.9 20892.7 21086.5 21276.8 21295.5 5735.3 6003.8 6072.1 6072.5 6074.1 4091.2 4367.7 5859.4 6526.8 6544.6 6440.5 6478.0 6479.8 6480.1 6486.7 5350.6 5609.8 5614.5 5640.9 6447.4 3754.0 5380.9 5501.5 5744.2 5752.2 13178.1 13193.0 13390.7 13398.7 13429.1 2107.7 2113.2 2196.2 2219.7 2706.9 9654.3 9832.3 9866.3 10074.9 10186.8 1709.6 1775.5 1781.5 1818.5 1968.4 105458.0 105609.0 108124.4 110235.4 110256.0 9689.5 11034.9 11199.5 11262.5 11375.6 13530.7 13548.3 13562.9 13571.4 13601.6 7348.3 8051.2 8429.0 8609.2 8669.5 8807.4 8818.6 8840.8 8905.1 8915.5 4062.2 4073.4 4360.0 4440.6 4488.2 1563.0 1846.6 1853.0 1856.6 1868.2 824.6 846.7 851.0 858.9 892.8 14831.5 17724.9 17854.7 18170.5 18519.1 872.9 899.7 905.4 905.5 907.7 9447.5 9683.8 9704.1 9780.1 9829.0 617965.0 622224.0 626423.0 628936.0 637688.0 82992.6 93937.0 116989.0 119782.0 120815.0 990.3 1001.0 1011.2 1023.5 1024.1 15713.7 15975.4 17940.6 17948.8 18177.9 50519.0 50802.0 51353.0 51940.0 52075.5 76019.2 77156.0 77264.0 77518.6 78916.0 7725.8 7807.9 7980.9 7997.5 8209.9 9927.0 12372.5 12471.6 12482.9 12887.8 7292.3 10331.6 10557.1 10794.3 10951.1 8088.2 10369.4 10411.8 10619.9 10753.4 10049.3 10539.2 10976.9 11681.8 11803.5 6368.4 7749.0 7889.6 7912.5 8130.6 8004.7 9848.9 11196.8 11266.2 11271.2 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6096.61 Median:5083.48 stddev:3183.55 (62.6%) stddev-sans-first:3171.83 07:33:58 INFO - PROCESS | 1674 | Values: 1272.9 1580.7 1603.4 1881.0 2025.6 7439.0 7876.8 8045.6 8267.2 8837.5 8501.8 8602.4 8641.7 8642.1 8794.6 2197.1 2250.3 2252.0 2477.3 2509.1 2274.4 2467.4 2538.0 2539.9 2543.2 2436.4 2471.0 2471.6 2479.2 2480.7 2156.0 2459.9 2460.5 2476.1 2489.2 2465.3 2490.3 2498.7 2500.7 2507.7 8900.1 8970.6 9005.8 9006.3 9011.0 5447.0 5542.9 5552.2 5604.3 5613.9 3511.6 3541.6 3694.6 3707.6 3724.6 1032.1 1038.3 1056.5 1057.8 1061.8 11990.8 12005.3 12025.6 12042.0 12068.8 4881.5 4974.9 5004.8 5034.1 5048.9 10219.8 10306.2 10316.8 10323.3 10349.5 5556.4 5594.2 5604.1 5604.3 5606.2 4474.8 4531.1 5075.3 5081.9 5085.0 3955.7 3955.8 4029.9 4033.6 4043.2 1286.6 1347.9 1353.1 1362.7 1366.0 1183.0 1191.6 1199.9 1392.4 1431.7 8092.7 8110.5 8154.7 8159.7 8189.7 1202.8 1213.8 1219.5 1222.9 1233.4 6374.3 6376.5 6454.9 6463.5 6469.9 10347.5 10735.0 10861.3 10875.2 10917.0 8613.0 10504.2 10512.6 10707.8 10744.4 8315.2 8374.9 8422.2 8470.8 8481.7 7799.9 7904.1 7944.5 7961.6 7994.2 9265.3 9539.4 9657.2 9666.2 9734.2 9648.9 9972.0 10051.0 10085.0 10093.0 7345.4 7530.7 7588.2 7589.8 7602.7 8328.3 8333.7 8373.6 8380.1 8393.1 7384.4 7459.8 7464.6 7590.9 7615.6 6743.3 7068.3 7354.9 7460.4 7520.5 7773.0 7827.3 7847.0 7847.6 7849.5 5911.8 7116.1 7179.6 7182.4 7189.5 7244.9 7299.1 7302.6 7314.4 7315.7 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5596.38 Median:6382.02 stddev:1795.00 (28.1%) stddev-sans-first:1755.80 07:33:58 INFO - PROCESS | 1674 | Values: 319.7 323.5 325.0 327.2 329.9 6413.5 6415.5 6515.3 6515.8 6537.0 6367.6 6396.4 6399.5 6429.1 6446.9 3750.3 4561.0 4624.9 4703.0 4787.2 4714.1 4717.9 4732.5 4749.9 4772.2 3815.5 4716.0 4722.8 4727.6 4746.4 3838.4 4538.4 4623.8 4716.2 4728.4 4093.5 4101.0 4102.4 4104.3 4120.2 5414.4 5668.8 6206.1 6209.3 6218.3 4592.2 5608.2 5615.0 5615.7 5622.3 6853.3 6869.0 6871.2 6880.2 6881.2 4425.2 4605.4 4614.3 4616.8 4639.8 6300.5 7094.9 7197.2 7285.2 7310.6 4567.1 4718.3 4719.1 4725.2 4728.7 4780.3 4785.0 4790.8 4803.4 4812.7 4592.6 5621.6 5627.7 5632.4 5634.4 6583.3 6638.2 6949.3 6967.8 6973.9 1388.9 1635.8 1657.4 1669.2 1675.8 931.9 1092.1 1097.0 1110.2 1118.3 6229.3 6313.3 6429.7 6524.2 6570.6 7271.1 7271.9 7274.4 7292.1 7307.0 6495.4 6508.1 6515.3 6522.2 6541.2 3426.9 3835.1 3841.3 3845.2 3849.5 7216.4 7567.1 7574.2 7581.2 7587.7 5733.0 6645.8 7395.7 7419.9 7422.3 6117.2 7543.1 7558.5 7559.7 7566.7 7190.2 7194.1 7195.6 7208.2 7209.9 6796.3 7076.2 7094.0 7108.0 7114.9 7413.6 7542.7 7548.9 7560.1 7570.6 4483.2 4536.3 4551.6 4553.2 4556.6 5792.7 7100.6 7128.5 7134.6 7214.4 6532.3 6873.8 6876.6 6907.7 6927.7 5609.0 6812.2 6864.3 6874.8 6882.7 5333.8 6728.9 6763.6 6764.9 6781.2 5594.6 6903.3 6908.9 6914.0 6918.2 5202.9 6077.8 6600.4 6604.5 6749.7 07:33:58 INFO - PROCESS | 1674 | 07:33:58 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18170.82 Median:619.56 stddev:25031.07 (4040.1%) stddev-sans-first:25066.69 07:33:58 INFO - PROCESS | 1674 | Values: 642.9 705.3 728.4 730.9 766.2 15001.3 15219.8 15233.9 15234.4 15287.2 10987.8 13876.8 14219.1 14298.6 14335.6 749.6 759.3 903.3 907.8 924.3 934.2 935.9 936.7 939.0 940.7 980.6 987.4 988.4 990.0 993.1 781.3 943.3 981.3 982.3 985.1 726.6 726.8 728.0 730.2 730.4 15080.7 15147.1 15185.8 15190.8 15218.8 12569.9 12624.9 12635.4 12641.2 12889.8 10050.7 10209.6 10294.3 10412.5 10903.0 3518.0 3522.1 3553.7 3616.3 3636.3 77598.0 78065.0 80461.6 81134.0 81166.6 9616.9 9714.1 9734.0 9848.0 10024.9 18300.2 22583.8 22616.0 22620.9 22623.9 7748.3 7802.9 7875.2 7963.4 7979.0 4154.6 4155.0 4161.2 4238.3 4287.0 3153.4 3713.7 3752.2 3754.9 3757.0 486.8 628.2 648.6 653.2 660.3 544.9 606.7 612.3 618.2 624.2 7852.5 8249.6 8285.5 8341.2 8561.7 530.7 593.7 598.1 602.8 620.9 3871.2 3886.4 3887.2 3945.4 4078.1 74582.3 78387.2 87786.0 91184.5 92200.5 65122.7 76653.6 77038.2 77599.6 78285.0 68201.7 68866.7 69714.9 70428.0 70452.0 6699.3 7407.9 7706.0 7809.1 7821.6 47790.8 49521.0 52893.2 56278.0 58472.1 67747.3 68187.7 69265.7 69344.7 71389.6 11739.9 11937.7 11975.3 12026.9 12533.9 11625.2 11748.9 12135.5 12511.2 13065.5 11083.3 11404.5 11525.4 11852.9 11922.2 11703.7 11970.3 12374.2 12379.2 12502.0 11527.1 11564.0 11807.2 11912.2 12506.5 9270.1 9554.6 9708.6 9818.5 10251.3 8560.5 8719.6 9111.0 9265.0 9369.3 07:33:58 INFO - PROCESS | 1674 | -------- Summary: end -------- 07:33:58 INFO - PROCESS | 1674 | 07:33:59 INFO - TEST-INFO | 1674: exit 0 07:33:59 INFO - TEST-OK | dromaeo_css | took 1114172ms 07:33:59 INFO - TEST-START | kraken 07:33:59 INFO - operating with platform_type : mac_ 07:33:59 INFO - Initialising browser for kraken test... 07:33:59 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpAlVBD4/profile http://localhost:49273/getInfo.html) 07:34:01 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 07:34:01 INFO - PROCESS | 1682 | colorDepth:24 07:34:01 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 07:34:01 INFO - PROCESS | 1682 | __metrics 07:34:01 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:34:01 ERROR - PROCESS | 1682 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:34:01 INFO - TEST-INFO | 1682: exit 0 07:34:01 INFO - Browser initialized. 07:34:01 INFO - Running cycle 1/1 for kraken test... 07:34:01 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpAlVBD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:14 INFO - PROCESS | 1685 | RSS: Main: 243118080 07:34:14 INFO - PROCESS | 1685 | 07:34:16 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:17 INFO - PROCESS | 1685 | RSS: Main: 290050048 07:34:17 INFO - PROCESS | 1685 | 07:34:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 07:34:20 INFO - PROCESS | 1685 | RSS: Main: 299458560 07:34:20 INFO - PROCESS | 1685 | 07:34:23 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 07:34:24 INFO - PROCESS | 1685 | RSS: Main: 285421568 07:34:24 INFO - PROCESS | 1685 | 07:34:26 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 07:34:26 INFO - PROCESS | 1685 | RSS: Main: 286674944 07:34:26 INFO - PROCESS | 1685 | 07:34:29 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:29 INFO - PROCESS | 1685 | RSS: Main: 287674368 07:34:29 INFO - PROCESS | 1685 | 07:34:32 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:33 INFO - PROCESS | 1685 | RSS: Main: 287363072 07:34:33 INFO - PROCESS | 1685 | 07:34:36 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:36 INFO - PROCESS | 1685 | RSS: Main: 286732288 07:34:36 INFO - PROCESS | 1685 | 07:34:39 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 07:34:39 INFO - PROCESS | 1685 | RSS: Main: 289456128 07:34:39 INFO - PROCESS | 1685 | 07:34:41 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:42 INFO - PROCESS | 1685 | RSS: Main: 322097152 07:34:42 INFO - PROCESS | 1685 | 07:34:43 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:44 INFO - PROCESS | 1685 | RSS: Main: 322056192 07:34:44 INFO - PROCESS | 1685 | 07:34:46 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:47 INFO - PROCESS | 1685 | RSS: Main: 331337728 07:34:47 INFO - PROCESS | 1685 | 07:34:49 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:50 INFO - PROCESS | 1685 | RSS: Main: 333017088 07:34:50 INFO - PROCESS | 1685 | 07:34:52 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:53 INFO - PROCESS | 1685 | RSS: Main: 334049280 07:34:53 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 07:34:55 INFO - PROCESS | 1685 | RSS: Main: 394346496 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | __start_tp_report 07:34:55 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 07:34:55 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 07:34:55 INFO - PROCESS | 1685 | |i|pagename|runs| 07:34:55 INFO - PROCESS | 1685 | |0;ai-astar;113;109;110;111;112;110;115;113;111;111 07:34:55 INFO - PROCESS | 1685 | |1;audio-beat-detection;155;121;139;159;143;186;171;143;159;118 07:34:55 INFO - PROCESS | 1685 | |2;audio-dft;184;185;185;186;184;186;181;180;185;179 07:34:55 INFO - PROCESS | 1685 | |3;audio-fft;73;75;85;76;56;61;58;79;75;55 07:34:55 INFO - PROCESS | 1685 | |4;audio-oscillator;90;95;140;120;116;97;115;76;78;115 07:34:55 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;94;101;94;76;135;130;132;92;95;86 07:34:55 INFO - PROCESS | 1685 | |6;imaging-darkroom;139;94;95;102;108;101;94;94;93;93 07:34:55 INFO - PROCESS | 1685 | |7;imaging-desaturate;84;84;86;88;86;86;86;85;88;85 07:34:55 INFO - PROCESS | 1685 | |8;json-parse-financial;55;56;56;55;53;54;54;63;56;52 07:34:55 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;64;71;63;77;71;69;67;68;67;68 07:34:55 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;80;82;82;86;96;105;106;82;82;83 07:34:55 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;125;114;131;121;131;120;120;119;122;125 07:34:55 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;138;126;140;139;137;122;135;138;137;137 07:34:55 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;67;66;66;67;67;69;69;66;68;66 07:34:55 INFO - PROCESS | 1685 | __end_tp_report 07:34:55 INFO - PROCESS | 1685 | __start_cc_report 07:34:55 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1204 07:34:55 INFO - PROCESS | 1685 | __end_cc_report 07:34:55 INFO - PROCESS | 1685 | __startTimestamp1457710495405__endTimestamp 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | ------- Summary: start ------- 07:34:55 INFO - PROCESS | 1685 | Number of tests: 14 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:1.78 (1.6%) stddev-sans-first:1.80 07:34:55 INFO - PROCESS | 1685 | Values: 113.0 109.0 110.0 111.0 112.0 110.0 115.0 113.0 111.0 111.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:157.00 stddev:21.09 (13.4%) stddev-sans-first:22.28 07:34:55 INFO - PROCESS | 1685 | Values: 155.0 121.0 139.0 159.0 143.0 186.0 171.0 143.0 159.0 118.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:183.50 Median:185.00 stddev:2.55 (1.4%) stddev-sans-first:2.70 07:34:55 INFO - PROCESS | 1685 | Values: 184.0 185.0 185.0 186.0 184.0 186.0 181.0 180.0 185.0 179.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:69.30 Median:75.00 stddev:10.76 (14.3%) stddev-sans-first:11.33 07:34:55 INFO - PROCESS | 1685 | Values: 73.0 75.0 85.0 76.0 56.0 61.0 58.0 79.0 75.0 55.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:77.00 stddev:20.34 (26.4%) stddev-sans-first:20.92 07:34:55 INFO - PROCESS | 1685 | Values: 90.0 95.0 140.0 120.0 116.0 97.0 115.0 76.0 78.0 115.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:103.50 Median:89.00 stddev:20.98 (23.6%) stddev-sans-first:21.97 07:34:55 INFO - PROCESS | 1685 | Values: 94.0 101.0 94.0 76.0 135.0 130.0 132.0 92.0 95.0 86.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:93.50 stddev:14.16 (15.1%) stddev-sans-first:5.30 07:34:55 INFO - PROCESS | 1685 | Values: 139.0 94.0 95.0 102.0 108.0 101.0 94.0 94.0 93.0 93.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 07:34:55 INFO - PROCESS | 1685 | Values: 84.0 84.0 86.0 88.0 86.0 86.0 86.0 85.0 88.0 85.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.99 (5.4%) stddev-sans-first:3.17 07:34:55 INFO - PROCESS | 1685 | Values: 55.0 56.0 56.0 55.0 53.0 54.0 54.0 63.0 56.0 52.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:3.95 (5.8%) stddev-sans-first:3.84 07:34:55 INFO - PROCESS | 1685 | Values: 64.0 71.0 63.0 77.0 71.0 69.0 67.0 68.0 67.0 68.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:82.00 stddev:10.07 (12.3%) stddev-sans-first:10.21 07:34:55 INFO - PROCESS | 1685 | Values: 80.0 82.0 82.0 86.0 96.0 105.0 106.0 82.0 82.0 83.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.50 stddev:5.33 (4.3%) stddev-sans-first:5.59 07:34:55 INFO - PROCESS | 1685 | Values: 125.0 114.0 131.0 121.0 131.0 120.0 120.0 119.0 122.0 125.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.90 Median:137.50 stddev:5.97 (4.3%) stddev-sans-first:6.23 07:34:55 INFO - PROCESS | 1685 | Values: 138.0 126.0 140.0 139.0 137.0 122.0 135.0 138.0 137.0 137.0 07:34:55 INFO - PROCESS | 1685 | 07:34:55 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 07:34:55 INFO - PROCESS | 1685 | Values: 67.0 66.0 66.0 67.0 67.0 69.0 69.0 66.0 68.0 66.0 07:34:55 INFO - PROCESS | 1685 | -------- Summary: end -------- 07:34:55 INFO - PROCESS | 1685 | 07:34:56 INFO - TEST-INFO | 1685: exit 0 07:34:56 INFO - TEST-OK | kraken | took 56938ms 07:34:56 INFO - SUITE-END | took 1171s 07:34:56 INFO - Completed test suite (00:19:31) 07:34:56 INFO - javascript benchmark 07:34:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3387.390269751445, 3449.8270588000105, 3454.7754395964243, 3484.268303656233, 3513.5081088647594, 5487.807926722566, 5610.859728506789, 5618.353889302732, 5618.438156184385, 5668.093105103184, 5587.804426845061, 5613.186088017245, 5629.690367029812, 5723.341815691197, 5755.1942728018, 5010.448850626428, 5049.9747501262445, 5058.924116138261, 5075.111855425286, 5186.988537235241, 5162.896742065156, 5173.922391164117, 5197.740112994354, 5224.712640804754, 5248.763805628737, 5003.1994880819075, 5017.8243761468175, 5096.643234973553, 5104.9744751276, 5143.254228136899, 5125.974370128126, 5140.33175687162, 5154.742262886841, 5159.251908473288, 5165.974170129125, 5006.799728010911, 5064.848054558369, 5086.033653605803, 5102.897942041175, 5103.948960510422, 5468.125099984023, 5495.890082198373, 5558.555315574744, 5589.580781441408, 5600.831975040755, 6060.816715659019, 6092.02527595587, 6104.175936248638, 6104.96947515264, 6108.053251745987, 6135.601185922946, 6178.474829639486, 6194.070889366586, 6201.379862013762, 6212.099245609406, 5569.721513924287, 5624.746886390122, 5659.43405659439, 5662.37713851476, 5672.950504156703, 6270.655113968684, 6325.683715814283, 6327.335629758809, 6330.461910737639, 6342.175517182829, 5922.0, 5930.673812940244, 5990.430909063632, 5999.430054144849, 6019.187409699634, 5504.036793561111, 6058.454739073504, 6128.869808884179, 6160.8767824643255, 6173.228346456693, 5361.605982444593, 5746.511546518593, 5764.654120752684, 6082.361352058058, 6129.049997250344, 6069.089636554552, 6079.908801367983, 6080.878382432326, 6086.513078953673, 6098.69506524672, 4716.740579268173, 4800.975995120002, 4801.879953001203, 4808.735519546389, 4821.975890120527, 4343.04453020335, 4347.826086956549, 4413.977930110329, 4414.690971631955, 4415.094905544356, 5547.33431988164, 5561.249231353715, 5574.972125139429, 5588.497035266845, 5588.888222235614, 6085.148079268906, 6100.581173165827, 6126.8230438726505, 6131.407250743292, 6148.1699970503405, 5583.944160558342, 5598.412166722435, 5604.4395560444445, 5612.1581762735095, 5627.943720562742, 5252.369715634149, 5259.421463638997, 5265.4997775211295, 5269.499397557226, 5316.494932981361, 6185.165002724574, 6222.377762223832, 6263.279722831932, 6310.589811662319, 6317.115603815561, 6059.272887253558, 6064.332923378513, 6067.089936509559, 6075.161351273365, 6090.786822461193, 6228.813135605939, 6306.180196574416, 6311.810645680637, 6334.588251763621, 6341.968290158519, 6027.728752206249, 6095.207623008981, 6096.847578810565, 6100.6949652516305, 6128.8774224516155, 6127.2514248266525, 6161.322254552086, 6162.506999440124, 6186.907196391968, 6196.442320191204, 5776.942230577641, 5925.111233315038, 5950.19672344228, 5957.434043765836, 5990.34106248321, 5695.088785794419, 5919.112133179885, 5919.289685237799, 5932.940670593239, 5963.373845746134, 5762.711864406847, 5782.074868021096, 5810.244668193277, 5811.854703632443, 5818.301803783573, 5731.799387021434, 5899.115132730125, 5954.553408494467, 5976.611520251344, 5990.6705131218205, 5816.94183058164, 5820.214271073351, 5822.94177058224, 5836.766529338779, 5843.795467158629], "unit": "score", "name": "dojo.html", "value": 5596.655578862673}, {"lowerIsBetter": false, "replicates": [492.76839885253963, 576.7491141353512, 577.6014549960527, 633.6704913445009, 637.0, 38851.61148388515, 39515.80242098793, 39544.60455395449, 39565.813025609204, 39599.40600890989, 42659.0, 42984.570154298446, 43062.354064688974, 43214.567854321445, 43313.78343108288, 9604.087611676898, 9807.803843923117, 9835.0, 9841.311108222428, 9845.852312215322, 9664.516774161299, 9802.166815820628, 9815.90184098157, 9819.901800982007, 9840.753981150458, 9904.0, 9981.90018099817, 9982.90017099827, 9995.350302230368, 10008.899911000906, 9887.802243955117, 9961.65134220306, 9966.20270378368, 9967.05312995268, 9988.400695958266, 9749.658761943369, 9862.45756483393, 9871.40771553702, 9881.209503239796, 9892.80214395708, 42150.78924605388, 42759.35860962088, 42826.143477130594, 42848.357274640905, 42854.0, 3238.2875767331147, 3297.406466835969, 3742.5883152853166, 3970.8808735737975, 4009.0, 28612.570811437847, 29546.40907181866, 29989.850050749825, 30109.849450752827, 30140.397192056254, 2782.8052036357262, 2845.47358738634, 2854.343500994783, 2857.4427986542632, 2866.65600127986, 378700.0, 381838.0, 381962.0901895501, 382376.0, 382475.0, 66445.66777166084, 66889.99665005029, 67000.0, 67085.66457167683, 67143.66428167828, 72100.59245556605, 72254.0, 72294.2770572298, 72324.0, 72389.0, 17551.91224043897, 17793.644127117386, 17813.0, 17827.0195139266, 17867.463976080737, 13441.663958401119, 13462.0, 13474.191548506926, 13483.865161348458, 13508.797368039488, 19796.426464559514, 20812.687809682866, 21011.78988210129, 21075.0, 21143.25998590042, 6471.932131198394, 8873.245774109144, 8918.955405222932, 9085.640051963652, 9242.214411775074, 960.4621412009298, 1014.6905193915926, 1069.2675517270695, 1130.1691260158595, 1143.2568830260398, 28624.690964191854, 29160.854195728887, 29643.25891852678, 30073.849630752145, 30097.398052038836, 1148.7013376522164, 1152.4813833774836, 1177.3112729053428, 1196.9401529923468, 1203.296071798008, 11967.162298639187, 14258.0, 14778.187199703905, 14945.0, 15147.621309467351, 490858.0, 510122.0, 517550.0, 517552.0, 517822.0, 59193.0, 59453.40546594565, 59551.808963820484, 59603.40396596065, 59666.80666386735, 1329.7473480038761, 1448.3265281644085, 1482.7331080405415, 1489.4935721854404, 1557.9298931548108, 24775.38061548476, 28658.426831463672, 28831.279218018877, 29505.819767209072, 29656.703432965394, 46971.53028469672, 47224.29163562618, 47598.76200618975, 47712.761436192595, 47737.0, 287442.0, 346874.0, 348779.0, 348780.0, 348975.0, 28699.85200591953, 33186.83406582951, 33750.324993500486, 34267.82866085654, 34296.31407371889, 42099.57900420957, 42726.35910461408, 42900.57099428966, 43181.784091079346, 44046.0, 35381.0, 35646.465303019955, 35831.0, 36074.63925360713, 36550.90347289586, 32225.35549289048, 34813.82593087018, 35303.64696353004, 35701.64298356983, 36919.44620830636, 35661.64338356583, 35833.46249806307, 36513.0, 36589.902302930954, 36817.63182368142, 26477.742822462627, 31513.8424307877, 31845.0, 32228.516572250966, 32239.194020149684, 23838.0, 23919.760802392448, 24249.51500970006, 24365.269041928063, 24423.38941526476], "unit": "score", "name": "ext.html", "value": 19805.121134993937}, {"lowerIsBetter": false, "replicates": [351.35526309222575, 351.5675718865795, 354.42052244580105, 361.095455883013, 362.98548058077677, 19546.92491912946, 19621.411357659275, 20720.378388648325, 20734.377968660945, 20746.377608671763, 20233.898830505863, 20892.686609700828, 21086.472838179052, 21276.787232127714, 21295.467613309676, 5735.2544169257935, 6003.849903752397, 6072.05883088122, 6072.544559158058, 6074.149619053336, 4091.2226676931286, 4367.650587952956, 5859.355470898197, 6526.836829079287, 6544.640044797534, 6440.484761219114, 6478.0, 6479.8056058318325, 6480.092787009822, 6486.708098135595, 5350.571954243651, 5609.775608975677, 5614.522765564931, 5640.943590564103, 6447.387498187664, 3753.962460375416, 5380.946190538084, 5501.504864562168, 5744.167095771131, 5752.223449834302, 13178.143420677721, 13193.0, 13390.665233369145, 13398.665033374145, 13429.127106738031, 2107.673310636854, 2113.186423227053, 2196.2422964077527, 2219.655953327237, 2706.945861082787, 9654.324197306192, 9832.31173817833, 9866.260030497742, 10074.949625251827, 10186.847197292047, 1709.5896984723577, 1775.5199808375598, 1781.5278951077846, 1818.4544636609096, 1968.3996381103757, 105458.0, 105609.0, 108124.42223610164, 110235.44882275537, 110256.0, 9689.515524223902, 11034.889651103547, 11199.496022678999, 11262.549498019987, 11375.601853935239, 13530.729385412236, 13548.322583870768, 13562.914966802633, 13571.389287482087, 13601.591952241251, 7348.338649521569, 8051.194880512019, 8429.0, 8609.225169734755, 8669.523176225368, 8807.383483156245, 8818.559072046372, 8840.823183536422, 8905.064968178378, 8915.465072095565, 4062.1672557125717, 4073.4113695658716, 4360.018995725936, 4440.578145076212, 4488.214562451558, 1562.9765553516706, 1846.6122114356135, 1852.990735046316, 1856.5544269375523, 1868.215349553191, 824.6330382979517, 846.6571038729325, 850.9829803403898, 858.888344515209, 892.8035832116924, 14831.480898168513, 17724.91137544304, 17854.732179017326, 18170.54573635643, 18519.074046297632, 872.8647059705755, 899.7030979776658, 905.3798148268457, 905.4929239625831, 907.7095329494631, 9447.480388578695, 9683.806323873483, 9704.126628603319, 9780.070893265129, 9829.0, 617965.0, 622224.0, 626423.0, 628936.0, 637688.0, 82992.58503707443, 93937.0, 116989.0, 119782.0, 120815.0, 990.2721499697716, 1000.9949950250202, 1011.1506334678905, 1023.467796745688, 1024.08856118055, 15713.68572628564, 15975.360985560448, 17940.641187176443, 17948.83332583378, 18177.909110454362, 50518.98962020665, 50802.0, 51353.0, 51940.0, 52075.47924520858, 76019.23980760343, 77156.0, 77264.0, 77518.61240693761, 78916.0, 7725.768226953201, 7807.882881756665, 7980.880286795818, 7997.480163789335, 8209.917900820916, 9927.0, 12372.505099795908, 12471.625851224479, 12482.937585312015, 12887.806682899576, 7292.34368906801, 10331.586736530455, 10557.102646275152, 10794.280107385057, 10951.137635210742, 8088.150744171778, 10369.429681367597, 10411.791764164826, 10619.893801061891, 10753.354798712102, 10049.296549241775, 10539.209559283237, 10976.890231097586, 11681.766364672489, 11803.527858885549, 6368.395002474757, 7748.9612551939135, 7889.605519724106, 7912.536180806569, 8130.593470326342, 8004.679812807422, 9848.867380251362, 11196.776064478501, 11266.211365204357, 11271.154663400443], "unit": "score", "name": "jquery.html", "value": 9009.03500983244}, {"lowerIsBetter": false, "replicates": [1272.8790764877344, 1580.7154712151812, 1603.4067395063823, 1880.9905950470245, 2025.6455120353935, 7439.0, 7876.763697089083, 8045.557494337809, 8267.214614611617, 8837.513936733478, 8501.829963400729, 8602.35482338824, 8641.740747777561, 8642.135786421355, 8794.648214071429, 2197.088208393515, 2250.3024062540667, 2251.966220506694, 2477.2568229531157, 2509.0841842727455, 2274.3859158027403, 2467.358486793438, 2537.974620253792, 2539.898404063835, 2543.2370288913253, 2436.3543660929868, 2470.950580988379, 2471.5798314286612, 2479.219046000513, 2480.6651102101164, 2155.9651367343604, 2459.913903013386, 2460.495598402323, 2476.0590975429313, 2489.240781561623, 2465.285067330472, 2490.2653717153485, 2498.650188973545, 2500.6874140732407, 2507.711613164473, 8900.109989001114, 8970.641174353019, 9005.819883602291, 9006.279497640238, 9010.954945225298, 5446.972765136188, 5542.889142217133, 5552.222688823568, 5604.299462567179, 5613.859653508654, 3511.5610548681416, 3541.557305336833, 3694.6305369463107, 3707.5921648618632, 3724.5902950675404, 1032.1278519650957, 1038.3302769713569, 1056.5351245451977, 1057.7937302226069, 1061.7929503746773, 11990.760184796256, 12005.339706316148, 12025.63923082309, 12042.0, 12068.758624827542, 4881.536254055859, 4974.875628109254, 5004.84985450437, 5034.144195486776, 5048.924266136011, 10219.846702299472, 10306.227032972558, 10316.845247321296, 10323.32898361604, 10349.482525873676, 5556.361018482926, 5594.1888426177975, 5604.103343465107, 5604.299462567179, 5606.243157173811, 4474.7762611869275, 4531.071130418256, 5075.314832497639, 5081.949180508222, 5085.0084233574835, 3955.6835453163676, 3955.782431966212, 4029.8992525187105, 4033.576474470197, 4043.1913617276664, 1286.6075846866795, 1347.905646604748, 1353.0799056641579, 1362.6729584899751, 1365.9795103073461, 1183.0476466444595, 1191.576990168495, 1199.8560172779148, 1392.4499822570028, 1431.720814441174, 8092.7167549136675, 8110.472819266729, 8154.6738130475305, 8159.67361305553, 8189.71336003249, 1202.7955247607927, 1213.83006379107, 1219.4878151176526, 1222.8715984821465, 1233.426456697622, 6374.266959299647, 6376.458001069868, 6454.935450645434, 6463.450606698483, 6469.935300646934, 10347.534360953776, 10735.0, 10861.34831910088, 10875.238733288752, 10917.0, 8613.0, 10504.212184086224, 10512.632057877938, 10707.785844283071, 10744.355338679705, 8315.210055044761, 8374.916250837414, 8422.24199822019, 8470.788230294169, 8481.660733570712, 7799.869018992328, 7904.051513818378, 7944.523328600302, 7961.562114083781, 7994.2405471480115, 9265.305102117234, 9539.379940303857, 9657.179139773198, 9666.226701863694, 9734.172595329477, 9648.903510965081, 9972.00279971997, 10051.0, 10085.041921017491, 10093.0, 7345.412367010733, 7530.6611202497115, 7588.241175882367, 7589.810254743676, 7602.7339043133225, 8328.292095171735, 8333.708320208763, 8373.62318695648, 8380.12008739098, 8393.118722534045, 7384.37232835215, 7459.813504662427, 7464.552126872405, 7590.886136707843, 7615.619219039137, 6743.325667433413, 7068.257832927674, 7354.880445871008, 7460.440466964891, 7520.473566850268, 7773.0, 7827.334676552557, 7847.0, 7847.646855891385, 7849.529028258323, 5911.822645320647, 7116.110486189226, 7179.641017948978, 7182.425405967615, 7189.460790440842, 7244.855102897807, 7299.05112335393, 7302.56184628924, 7314.378277846443, 7315.743948961761], "unit": "score", "name": "mootools.html", "value": 4986.784497126802}, {"lowerIsBetter": false, "replicates": [319.7122589669297, 323.5211886408116, 324.95195070241135, 327.1804130652715, 329.8845404108564, 6413.518986076046, 6415.45468635166, 6515.31589183136, 6515.8371040724005, 6536.967315163418, 6367.617942923416, 6396.424321811036, 6399.488040956724, 6429.067785171147, 6446.903296450545, 3750.306193354238, 4561.0, 4624.907501849961, 4702.97648511757, 4787.186178349681, 4714.080754252922, 4717.858464246078, 4732.526747325274, 4749.928751068719, 4772.236442169236, 3815.5421349437966, 4716.033213191287, 4722.8110875564935, 4727.645426593002, 4746.382970213867, 3838.4242363645535, 4538.364628951933, 4623.768811559408, 4716.245400735866, 4728.432588089417, 4093.5497095319492, 4100.979495102535, 4102.384642303648, 4104.281750693646, 4120.196561670476, 5414.377346605152, 5668.809549994506, 6206.069089636546, 6209.316975132777, 6218.347073557302, 4592.173408786417, 5608.233406476947, 5615.0454422748235, 5615.6630602164005, 5622.32532096151, 6853.348931851466, 6868.965655171743, 6871.244163142051, 6880.174379074493, 6881.208661003999, 4425.15921974827, 4605.37827393301, 4614.330922016289, 4616.792244349012, 4639.837605683819, 6300.495960323209, 7094.893576596355, 7197.172325182619, 7285.198628150899, 7310.550965426589, 4567.10941366437, 4718.339432479455, 4719.10337035962, 4725.1730947084125, 4728.692634978715, 4780.259059845729, 4785.042991401733, 4790.8323208687525, 4803.3995750531185, 4812.711237325701, 4592.609628181575, 5621.634593751393, 5627.6904770237215, 5632.3804381518, 5634.408387119293, 6583.341665833378, 6638.249389095242, 6949.339812717783, 6967.825804354931, 6973.930260697328, 1388.8680575345327, 1635.8200597934217, 1657.3867668962562, 1669.2071266148725, 1675.7570152327844, 931.8602209668604, 1092.1426680056118, 1097.0181687389902, 1110.2339385823757, 1118.278710231896, 6229.283632382243, 6313.337099604567, 6429.710663020175, 6524.217093948661, 6570.638614876228, 7271.1279044778075, 7271.854562908818, 7274.381677557361, 7292.052033235752, 7306.977023216754, 6495.350464953467, 6508.121403610452, 6515.283318834924, 6522.21733391996, 6541.2150541934325, 3426.8629254830025, 3835.079580900564, 3841.2893614681375, 3845.1540661054523, 3849.4610754494392, 7216.386607138347, 7567.0703970487175, 7574.242575742492, 7581.203973582695, 7587.734429294948, 5732.996725573008, 6645.800625981228, 7395.741149059757, 7419.85160296791, 7422.294881986203, 6117.235345581802, 7543.0948286206, 7558.470907036454, 7559.697612095454, 7566.659500322498, 7190.245024272376, 7194.136703595393, 7195.568265904062, 7208.243134470805, 7209.855802884018, 6796.320367963164, 7076.221615622175, 7093.964530177316, 7108.0, 7114.893276600752, 7413.629318534159, 7542.6605802740105, 7548.8676698495665, 7560.054993125859, 7570.621468926642, 4483.170613436394, 4536.251518499411, 4551.590356867898, 4553.180427522945, 4556.567126123013, 5792.652440853562, 7100.644967751695, 7128.536645118258, 7134.643267836691, 7214.386777123793, 6532.314107018885, 6873.793786186422, 6876.587404755731, 6907.6891539881835, 6927.653617319214, 5609.0, 6812.182538095461, 6864.313568643096, 6874.759383421556, 6882.655867206719, 5333.759980800795, 6728.932710673026, 6763.613459240745, 6764.93235067643, 6781.220159681699, 5594.636348637326, 6903.309669033057, 6908.860038093659, 6914.0, 6918.169819621678, 5202.869928251824, 6077.848053798691, 6600.372964568358, 6604.504662150454, 6749.696263668245], "unit": "score", "name": "prototype.html", "value": 5006.840213319532}, {"lowerIsBetter": false, "replicates": [642.8617847162859, 705.2594775485742, 728.4136270302411, 730.9195988441271, 766.1763604125565, 15001.324940377683, 15219.84780152198, 15233.933624646279, 15234.390624375039, 15287.235638218086, 10987.780244395108, 13876.791848122286, 14219.14685118891, 14298.642533936656, 14335.64160895978, 749.6401727170961, 759.3128218961848, 903.2999425445266, 907.8320510705507, 924.3483344242293, 934.243262957007, 935.8502639577669, 936.6862101196108, 938.9952750556907, 940.6895724410928, 980.6126580000895, 987.4075554667214, 988.3625061835112, 990.044606954289, 993.1161266472845, 781.3436713160944, 943.3208090175063, 981.2738573455663, 982.3172894838091, 985.093713783321, 726.5749536521141, 726.8073960400445, 728.0317178153043, 730.1894896664697, 730.3974221267423, 15080.698386032218, 15147.091174529563, 15185.848141518554, 15190.772138417933, 15218.771718424232, 12569.937150314281, 12624.873751262461, 12635.43140558677, 12641.2415255085, 12889.806652900214, 10050.69847904564, 10209.591616335338, 10294.279400441972, 10412.531436085394, 10902.96421839924, 3517.99574813421, 3522.101864024683, 3553.6979356754705, 3616.258218768695, 3636.272745450894, 77598.0, 78065.0, 80461.59769201175, 81134.0, 81166.59416702938, 9616.855747163798, 9714.072042876729, 9734.02659734021, 9847.950760246153, 10024.899751002396, 18300.17649205789, 22583.774162258494, 22615.982280797405, 22620.886895565418, 22623.868806559607, 7748.263914928186, 7802.882956755653, 7875.173106823701, 7963.362930965509, 7979.0425148982495, 4154.646855017358, 4155.0, 4161.209370219649, 4238.321868501025, 4287.035417031206, 3153.369326134782, 3713.7400381973002, 3752.2307926874923, 3754.8685795997553, 3757.04195430169, 486.8125771577968, 628.2084573437411, 648.614074625597, 653.1509038250256, 660.2769966886252, 544.9291592093002, 606.7239406070228, 612.3325575123138, 618.1809102938535, 624.1698540940538, 7852.450328477066, 8249.587520623945, 8285.50286982783, 8341.165883411732, 8561.657533698706, 530.6736357140331, 593.6813214133017, 598.0795882987062, 602.7679343452802, 620.9472194863397, 3871.2064026874423, 3886.358750806142, 3887.1642596841248, 3945.447637330776, 4078.1435898461655, 74582.25417745861, 78387.216127838, 87786.0, 91184.54407727919, 92200.53899730458, 65122.674386628714, 76653.61673191599, 77038.22961770311, 77599.61200193963, 78285.0, 68201.65899170472, 68866.65566672134, 69714.91984463636, 70428.0, 70452.0, 6699.330066993261, 7407.925920740724, 7705.961470192613, 7809.1409944907155, 7821.648025838737, 47790.80522986953, 49521.0, 52893.20660190023, 56278.0, 58472.106265653594, 67747.3225267741, 68187.65906170437, 69265.72709865593, 69344.6532767333, 71389.5722085545, 11739.943405093583, 11937.701557461132, 11975.341356225492, 12026.939865300617, 12533.874661253636, 11625.18623696333, 11748.941255293668, 12135.453904574491, 12511.249325040526, 13065.542706005244, 11083.279586826831, 11404.48679809427, 11525.366104864313, 11852.940735296268, 11922.165448418527, 11703.707407314885, 11970.281783093042, 12374.195677280948, 12379.195352302071, 12502.0, 11527.077833773446, 11564.0, 11807.23252988553, 11912.225705329125, 12506.499740010298, 9270.119338662817, 9554.570044347882, 9708.563114659715, 9818.45998470091, 10251.333663311862, 8560.493323312743, 8719.607617657093, 9111.043340449158, 9264.95367523158, 9369.297302702189], "unit": "score", "name": "yui.html", "value": 6957.278141026936}], "name": "dromaeo_css", "value": 7468.049457973198}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 110.0, 111.0, 112.0, 110.0, 115.0, 113.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 139.0, 159.0, 143.0, 186.0, 171.0, 143.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 185.0, 186.0, 184.0, 186.0, 181.0, 180.0, 185.0, 179.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 85.0, 76.0, 56.0, 61.0, 58.0, 79.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 140.0, 120.0, 116.0, 97.0, 115.0, 76.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 104.2}, {"lowerIsBetter": true, "replicates": [94.0, 101.0, 94.0, 76.0, 135.0, 130.0, 132.0, 92.0, 95.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.5}, {"lowerIsBetter": true, "replicates": [139.0, 94.0, 95.0, 102.0, 108.0, 101.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 101.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 88.0, 86.0, 86.0, 86.0, 85.0, 88.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 55.0, 53.0, 54.0, 54.0, 63.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 63.0, 77.0, 71.0, 69.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 86.0, 96.0, 105.0, 106.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [125.0, 114.0, 131.0, 121.0, 131.0, 120.0, 120.0, 119.0, 122.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 140.0, 139.0, 137.0, 122.0, 135.0, 138.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 69.0, 69.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1445.6}]} 07:34:56 INFO - Return code: 0 07:34:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:56 ERROR - # TBPL SUCCESS # 07:34:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:56 INFO - 2016-03-11 07:34:56.721 screenresolution[1689:10097] starting screenresolution argv=screenresolution get 07:34:56 INFO - 2016-03-11 07:34:56.724 screenresolution[1689:10097] Display 0: 1600x1200x32@60 07:34:56 INFO - 2016-03-11 07:34:56.729 screenresolution[1690:10100] starting screenresolution argv=screenresolution list 07:34:56 INFO - Available Modes on Display 0 07:34:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:56 INFO - Intel Iris: 07:34:56 INFO - Chipset Model: Intel Iris 07:34:56 INFO - Type: GPU 07:34:56 INFO - Bus: Built-In 07:34:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:56 INFO - Vendor: Intel (0x8086) 07:34:56 INFO - Device ID: 0x0a2e 07:34:56 INFO - Revision ID: 0x0009 07:34:56 INFO - Displays: 07:34:56 INFO - Display: 07:34:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:56 INFO - Display Serial Number: 1600x1200 60 07:34:56 INFO - Main Display: Yes 07:34:56 INFO - Mirror: Off 07:34:56 INFO - Online: Yes 07:34:56 INFO - Rotation: Supported 07:34:56 INFO - Return code: 0 07:34:56 INFO - Running post-action listener: _resource_record_post_action 07:34:56 INFO - Running post-run listener: _resource_record_post_run 07:34:58 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34090496; Write bytes: 703574016; Read time: 475; Write time: 3006 07:34:58 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389102080; Write bytes: 383813632; Read time: 30063; Write time: 694 07:34:58 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33168896; Write bytes: 299132928; Read time: 462; Write time: 2236 07:34:58 INFO - Running post-run listener: _upload_blobber_files 07:34:58 INFO - Blob upload gear active. 07:34:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:58 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 07:34:58 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'] 07:34:58 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 07:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:59 INFO - (blobuploader) - INFO - Done attempting. 07:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:00 INFO - (blobuploader) - INFO - Done attempting. 07:35:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:00 INFO - Return code: 0 07:35:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd2df700090ff0f622705de100979943a5b13975f1d9f61468e7bec555edebe7375a048d0b8ac0f6ec3814a6d52ce7b124b7e8b3356bb543079a57debed299a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8448f08d69840257b04f4d2e7eff8fa072badb6ac6439df26dcaed6f7c0ee88a02f3b7cae9b864b76e1b1a1e87289bc4f5e6bd764159fe923a5c6d23f531039b"} 07:35:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:00 INFO - Contents: 07:35:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd2df700090ff0f622705de100979943a5b13975f1d9f61468e7bec555edebe7375a048d0b8ac0f6ec3814a6d52ce7b124b7e8b3356bb543079a57debed299a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8448f08d69840257b04f4d2e7eff8fa072badb6ac6439df26dcaed6f7c0ee88a02f3b7cae9b864b76e1b1a1e87289bc4f5e6bd764159fe923a5c6d23f531039b"} 07:35:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:00 INFO - Copying logs to upload dir... 07:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.877387 ========= master_lag: 3.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-11 07:35:03.360072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 07:35:03.362793) ========= 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.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd2df700090ff0f622705de100979943a5b13975f1d9f61468e7bec555edebe7375a048d0b8ac0f6ec3814a6d52ce7b124b7e8b3356bb543079a57debed299a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8448f08d69840257b04f4d2e7eff8fa072badb6ac6439df26dcaed6f7c0ee88a02f3b7cae9b864b76e1b1a1e87289bc4f5e6bd764159fe923a5c6d23f531039b"} build_url:https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010993 build_url: 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdd2df700090ff0f622705de100979943a5b13975f1d9f61468e7bec555edebe7375a048d0b8ac0f6ec3814a6d52ce7b124b7e8b3356bb543079a57debed299a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8448f08d69840257b04f4d2e7eff8fa072badb6ac6439df26dcaed6f7c0ee88a02f3b7cae9b864b76e1b1a1e87289bc4f5e6bd764159fe923a5c6d23f531039b"}' ========= master_lag: 1.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 07:35:04.621347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-03-11 07:35:04.621643) ========= 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.TTYjnslgsf/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.WahkABkwEU/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005308 ========= master_lag: 7.85 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-03-11 07:35:12.475896) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-11 07:35:12.476190) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-11 07:35:17.190203) ========= ========= Total master_lag: 26.19 =========