builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1460622486.3 results: success (0) buildid: 20160413234048 builduid: 79433b98ada847f397e9d98687080136 revision: 7d39fe1e571c9bd656d66e05732ebd11419c5e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.300695) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.301129) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.301423) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005407 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.324336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.324616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.341061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.341329) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005339 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.389393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.389676) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.390073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.390355) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-04-14 01:28:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.75M=0.002s 2016-04-14 01:28:06 (5.75 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.522154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.522468) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.018965 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:06.570403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 01:28:06.570758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7d39fe1e571c9bd656d66e05732ebd11419c5e77 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7d39fe1e571c9bd656d66e05732ebd11419c5e77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-04-14 01:28:06,639 truncating revision to first 12 chars 2016-04-14 01:28:06,639 Setting DEBUG logging. 2016-04-14 01:28:06,639 attempt 1/10 2016-04-14 01:28:06,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7d39fe1e571c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 01:28:07,897 unpacking tar archive at: mozilla-aurora-7d39fe1e571c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.504897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 01:28:08.092020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:08.092396) ========= echo 7d39fe1e571c9bd656d66e05732ebd11419c5e77 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7d39fe1e571c9bd656d66e05732ebd11419c5e77'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 7d39fe1e571c9bd656d66e05732ebd11419c5e77 program finished with exit code 0 elapsedTime=0.004950 script_repo_revision: '7d39fe1e571c9bd656d66e05732ebd11419c5e77' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:08.141354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:08.141647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 01:28:08.154891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-14 01:28:08.155190) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:08 INFO - MultiFileLogger online at 20160414 01:28:08 in /builds/slave/test 01:28:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:28:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:28:08 INFO - {'append_to_log': False, 01:28:08 INFO - 'base_work_dir': '/builds/slave/test', 01:28:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:28:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:28:08 INFO - 'branch': 'Mozilla-Aurora', 01:28:08 INFO - 'buildbot_json_path': 'buildprops.json', 01:28:08 INFO - 'config_files': ('talos/mac_config.py',), 01:28:08 INFO - 'default_actions': ('clobber', 01:28:08 INFO - 'read-buildbot-config', 01:28:08 INFO - 'download-and-extract', 01:28:08 INFO - 'populate-webroot', 01:28:08 INFO - 'create-virtualenv', 01:28:08 INFO - 'install', 01:28:08 INFO - 'run-tests'), 01:28:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:28:08 INFO - 'download_minidump_stackwalk': True, 01:28:08 INFO - 'download_symbols': 'ondemand', 01:28:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:28:08 INFO - 'tooltool.py': '/tools/tooltool.py', 01:28:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:28:08 INFO - '/tools/misc-python/virtualenv.py')}, 01:28:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:28:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:28:08 INFO - 'installer_path': 'installer.exe', 01:28:08 INFO - 'log_level': 'info', 01:28:08 INFO - 'log_name': 'talos', 01:28:08 INFO - 'log_to_console': True, 01:28:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:28:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:28:08 INFO - 'opt_config_files': (), 01:28:08 INFO - 'pip_index': False, 01:28:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:28:08 INFO - 'cmd': ('bash', 01:28:08 INFO - '-c', 01:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:28:08 INFO - 'enabled': True, 01:28:08 INFO - 'halt_on_failure': False, 01:28:08 INFO - 'name': 'check_screen_resolution'},), 01:28:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:28:08 INFO - 'cmd': ('bash', 01:28:08 INFO - '-c', 01:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:28:08 INFO - 'enabled': True, 01:28:08 INFO - 'halt_on_failure': False, 01:28:08 INFO - 'name': 'check_screen_resolution'},), 01:28:08 INFO - 'run_cmd_checks_enabled': True, 01:28:08 INFO - 'sps_profile': False, 01:28:08 INFO - 'sps_profile_interval': 0, 01:28:08 INFO - 'suite': 'dromaeojs', 01:28:08 INFO - 'system_bits': '32', 01:28:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:28:08 INFO - 'title': 't-yosemite-r7-0152', 01:28:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:28:08 INFO - 'use_talos_json': True, 01:28:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:28:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:28:08 INFO - 'work_dir': 'build'} 01:28:08 INFO - ##### 01:28:08 INFO - ##### Running clobber step. 01:28:08 INFO - ##### 01:28:08 INFO - Running pre-action listener: _resource_record_pre_action 01:28:08 INFO - Running main action method: clobber 01:28:08 INFO - rmtree: /builds/slave/test/build 01:28:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:28:09 INFO - Running post-action listener: _resource_record_post_action 01:28:09 INFO - ##### 01:28:09 INFO - ##### Running read-buildbot-config step. 01:28:09 INFO - ##### 01:28:09 INFO - Running pre-action listener: _resource_record_pre_action 01:28:09 INFO - Running main action method: read_buildbot_config 01:28:09 INFO - Using buildbot properties: 01:28:09 INFO - { 01:28:09 INFO - "project": "", 01:28:09 INFO - "product": "firefox", 01:28:09 INFO - "script_repo_revision": "production", 01:28:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:28:09 INFO - "repository": "", 01:28:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:28:09 INFO - "buildid": "20160413234048", 01:28:09 INFO - "pgo_build": "False", 01:28:09 INFO - "basedir": "/builds/slave/test", 01:28:09 INFO - "buildnumber": 175, 01:28:09 INFO - "slavename": "t-yosemite-r7-0152", 01:28:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:28:09 INFO - "platform": "yosemite_r7", 01:28:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:28:09 INFO - "branch": "mozilla-aurora", 01:28:09 INFO - "repo_path": "releases/mozilla-aurora", 01:28:09 INFO - "revision": "7d39fe1e571c9bd656d66e05732ebd11419c5e77", 01:28:09 INFO - "stage_platform": "macosx64", 01:28:09 INFO - "builduid": "79433b98ada847f397e9d98687080136", 01:28:09 INFO - "slavebuilddir": "test" 01:28:09 INFO - } 01:28:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 01:28:09 INFO - Running post-action listener: _resource_record_post_action 01:28:09 INFO - ##### 01:28:09 INFO - ##### Running download-and-extract step. 01:28:09 INFO - ##### 01:28:09 INFO - Running pre-action listener: _resource_record_pre_action 01:28:09 INFO - Running main action method: download_and_extract 01:28:09 INFO - mkdir: /builds/slave/test/build/tests 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 01:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 01:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 01:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 01:28:11 INFO - Downloaded 1277 bytes. 01:28:11 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 01:28:11 INFO - Using the following test package requirements: 01:28:11 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:28:11 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 01:28:11 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 01:28:11 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'jsshell-mac.zip'], 01:28:11 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 01:28:11 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:28:11 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 01:28:11 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 01:28:11 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 01:28:11 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:28:11 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:28:11 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 01:28:11 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:28:11 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')]} 01:28:11 INFO - https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:28:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:28:12 INFO - Downloaded 17911041 bytes. 01:28:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:28:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:28:15 INFO - Return code: 0 01:28:15 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:15 INFO - https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:28:16 INFO - Downloaded 17911041 bytes. 01:28:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:28:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:28:19 INFO - Return code: 0 01:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:19 INFO - https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:28:21 INFO - Downloaded 10845168 bytes. 01:28:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:28:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:28:21 INFO - Return code: 0 01:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:21 INFO - https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 01:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 01:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 01:28:24 INFO - Downloaded 115203907 bytes. 01:28:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:28:24 INFO - mkdir: /builds/slave/test/properties 01:28:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:28:24 INFO - Writing to file /builds/slave/test/properties/build_url 01:28:24 INFO - Contents: 01:28:24 INFO - build_url:https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:28:25 INFO - Running post-action listener: _resource_record_post_action 01:28:25 INFO - Running post-action listener: set_extra_try_arguments 01:28:25 INFO - ##### 01:28:25 INFO - ##### Running populate-webroot step. 01:28:25 INFO - ##### 01:28:25 INFO - Running pre-action listener: _resource_record_pre_action 01:28:25 INFO - Running main action method: populate_webroot 01:28:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:28:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:28:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:28:25 INFO - '--tppagecycles', 01:28:25 INFO - '7'], 01:28:25 INFO - 'tests': ['tsvgm']}}, 01:28:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:28:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:28:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:28:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:28:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:28:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:28:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'tests': ['damp', 'tps']}, 01:28:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['damp', 'tps']}, 01:28:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:28:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:28:25 INFO - 'other': {'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'other_l64': {'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'other_nol64': {'tests': ['a11yr', 01:28:25 INFO - 'ts_paint', 01:28:25 INFO - 'tpaint', 01:28:25 INFO - 'sessionrestore', 01:28:25 INFO - 'sessionrestore_no_auto_restore', 01:28:25 INFO - 'tabpaint']}, 01:28:25 INFO - 'svgr': {'tests': ['tsvgx', 01:28:25 INFO - 'tsvgr_opacity', 01:28:25 INFO - 'tart', 01:28:25 INFO - 'tscrollx', 01:28:25 INFO - 'cart']}, 01:28:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['tsvgx', 01:28:25 INFO - 'tsvgr_opacity', 01:28:25 INFO - 'tart', 01:28:25 INFO - 'tscrollx', 01:28:25 INFO - 'cart']}, 01:28:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'tests': ['tp5o']}, 01:28:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'talos_options': ['--e10s'], 01:28:25 INFO - 'tests': ['tp5o']}, 01:28:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'talos_options': ['--xperf_path', 01:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:28:25 INFO - 'tests': ['tp5n']}, 01:28:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:25 INFO - 'talos_options': ['--e10s', 01:28:25 INFO - '--xperf_path', 01:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:28:25 INFO - 'tests': ['tp5n']}}, 01:28:25 INFO - 'talos.zip': {'path': '', 01:28:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:28:25 INFO - Running post-action listener: _resource_record_post_action 01:28:25 INFO - ##### 01:28:25 INFO - ##### Running create-virtualenv step. 01:28:25 INFO - ##### 01:28:25 INFO - Running pre-action listener: _resource_record_pre_action 01:28:25 INFO - Running main action method: create_virtualenv 01:28:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:28:25 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 01:28:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:28:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:28:25 INFO - Using real prefix '/tools/python27' 01:28:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:28:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:28:29 INFO - Installing pip.................done. 01:28:29 INFO - Return code: 0 01:28:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:28:29 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')]} 01:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:29 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')]} 01:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:29 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:29 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 01:28:29 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 01:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:29 INFO - 'HOME': '/Users/cltbld', 01:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:29 INFO - 'LOGNAME': 'cltbld', 01:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:29 INFO - 'MOZ_NO_REMOTE': '1', 01:28:29 INFO - 'NO_EM_RESTART': '1', 01:28:29 INFO - 'PAGER': '/bin/cat', 01:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:29 INFO - 'PWD': '/builds/slave/test', 01:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:29 INFO - 'SHELL': '/bin/bash', 01:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:29 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:29 INFO - 'USER': 'cltbld', 01:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:29 INFO - 'XPC_FLAGS': '0x0', 01:28:29 INFO - 'XPC_SERVICE_NAME': '0', 01:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:29 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 01:28:29 INFO - Cleaning up... 01:28:29 INFO - Return code: 0 01:28:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:28:29 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')]} 01:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:29 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')]} 01:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:29 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:29 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 01:28:29 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 01:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:29 INFO - 'HOME': '/Users/cltbld', 01:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:29 INFO - 'LOGNAME': 'cltbld', 01:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:29 INFO - 'MOZ_NO_REMOTE': '1', 01:28:29 INFO - 'NO_EM_RESTART': '1', 01:28:29 INFO - 'PAGER': '/bin/cat', 01:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:29 INFO - 'PWD': '/builds/slave/test', 01:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:29 INFO - 'SHELL': '/bin/bash', 01:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:29 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:29 INFO - 'USER': 'cltbld', 01:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:29 INFO - 'XPC_FLAGS': '0x0', 01:28:29 INFO - 'XPC_SERVICE_NAME': '0', 01:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:29 INFO - Downloading/unpacking psutil>=0.7.1 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:28:32 INFO - Installing collected packages: psutil 01:28:32 INFO - Running setup.py install for psutil 01:28:32 INFO - building 'psutil._psutil_osx' extension 01:28:32 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 01:28:33 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 01:28:33 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 01:28:33 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 01:28:33 INFO - building 'psutil._psutil_posix' extension 01:28:33 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 01:28:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:28:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:28:33 INFO - ^ 01:28:33 INFO - 1 warning generated. 01:28:33 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 01:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:28:33 INFO - Successfully installed psutil 01:28:33 INFO - Cleaning up... 01:28:33 INFO - Return code: 0 01:28:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:28:33 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')]} 01:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:33 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')]} 01:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:33 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:33 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 01:28:33 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 01:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:33 INFO - 'HOME': '/Users/cltbld', 01:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:33 INFO - 'LOGNAME': 'cltbld', 01:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:33 INFO - 'MOZ_NO_REMOTE': '1', 01:28:33 INFO - 'NO_EM_RESTART': '1', 01:28:33 INFO - 'PAGER': '/bin/cat', 01:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:33 INFO - 'PWD': '/builds/slave/test', 01:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:33 INFO - 'SHELL': '/bin/bash', 01:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:33 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:33 INFO - 'USER': 'cltbld', 01:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:33 INFO - 'XPC_FLAGS': '0x0', 01:28:33 INFO - 'XPC_SERVICE_NAME': '0', 01:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:28:36 INFO - Installing collected packages: mozsystemmonitor 01:28:36 INFO - Running setup.py install for mozsystemmonitor 01:28:36 INFO - Successfully installed mozsystemmonitor 01:28:36 INFO - Cleaning up... 01:28:36 INFO - Return code: 0 01:28:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:36 INFO - 'HOME': '/Users/cltbld', 01:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:36 INFO - 'LOGNAME': 'cltbld', 01:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:36 INFO - 'MOZ_NO_REMOTE': '1', 01:28:36 INFO - 'NO_EM_RESTART': '1', 01:28:36 INFO - 'PAGER': '/bin/cat', 01:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:36 INFO - 'PWD': '/builds/slave/test', 01:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:36 INFO - 'SHELL': '/bin/bash', 01:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:36 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:36 INFO - 'USER': 'cltbld', 01:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:36 INFO - 'XPC_FLAGS': '0x0', 01:28:36 INFO - 'XPC_SERVICE_NAME': '0', 01:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:36 INFO - Downloading/unpacking blobuploader==1.2.4 01:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:39 INFO - Downloading blobuploader-1.2.4.tar.gz 01:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:28:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:28:39 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 01:28:39 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 01:28:39 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 01:28:39 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 01:28:39 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 01:28:39 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 01:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:28:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:40 INFO - Downloading docopt-0.6.1.tar.gz 01:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:28:40 INFO - Installing collected packages: blobuploader, requests, docopt 01:28:40 INFO - Running setup.py install for blobuploader 01:28:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:28:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:28:40 INFO - Running setup.py install for requests 01:28:41 INFO - Running setup.py install for docopt 01:28:41 INFO - Successfully installed blobuploader requests docopt 01:28:41 INFO - Cleaning up... 01:28:41 INFO - Return code: 0 01:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:41 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')]} 01:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:41 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')]} 01:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:41 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:41 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 01:28:41 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 01:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:41 INFO - 'HOME': '/Users/cltbld', 01:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:41 INFO - 'LOGNAME': 'cltbld', 01:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:41 INFO - 'MOZ_NO_REMOTE': '1', 01:28:41 INFO - 'NO_EM_RESTART': '1', 01:28:41 INFO - 'PAGER': '/bin/cat', 01:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:41 INFO - 'PWD': '/builds/slave/test', 01:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:41 INFO - 'SHELL': '/bin/bash', 01:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:41 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:41 INFO - 'USER': 'cltbld', 01:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:41 INFO - 'XPC_FLAGS': '0x0', 01:28:41 INFO - 'XPC_SERVICE_NAME': '0', 01:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:41 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-dqCVbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:41 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Xyythu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:41 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8x1qgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-j3wsZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-LJ_IdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-hqu6eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GEGZwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-tMkhx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-x2Lhnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-hd9vDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5W6dHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-722RPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:42 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8pHKPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:43 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-KbBCVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:43 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-piTY86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:43 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-RBGX9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:43 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Hyi56i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:28:43 INFO - Running setup.py install for manifestparser 01:28:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:28:43 INFO - Running setup.py install for mozcrash 01:28:43 INFO - Running setup.py install for mozdebug 01:28:43 INFO - Running setup.py install for mozdevice 01:28:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Running setup.py install for mozfile 01:28:44 INFO - Running setup.py install for mozhttpd 01:28:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Running setup.py install for mozinfo 01:28:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Running setup.py install for mozInstall 01:28:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Running setup.py install for mozleak 01:28:44 INFO - Running setup.py install for mozlog 01:28:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:28:44 INFO - Running setup.py install for moznetwork 01:28:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:28:45 INFO - Running setup.py install for mozprocess 01:28:45 INFO - Running setup.py install for mozprofile 01:28:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:28:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:28:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:28:45 INFO - Running setup.py install for mozrunner 01:28:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:28:45 INFO - Running setup.py install for mozscreenshot 01:28:45 INFO - Running setup.py install for moztest 01:28:45 INFO - Running setup.py install for mozversion 01:28:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:28:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:28:46 INFO - Cleaning up... 01:28:46 INFO - Return code: 0 01:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:46 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')]} 01:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:46 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')]} 01:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:46 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:46 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 01:28:46 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 01:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:46 INFO - 'HOME': '/Users/cltbld', 01:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:46 INFO - 'LOGNAME': 'cltbld', 01:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:46 INFO - 'MOZ_NO_REMOTE': '1', 01:28:46 INFO - 'NO_EM_RESTART': '1', 01:28:46 INFO - 'PAGER': '/bin/cat', 01:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:46 INFO - 'PWD': '/builds/slave/test', 01:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:46 INFO - 'SHELL': '/bin/bash', 01:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:46 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:46 INFO - 'USER': 'cltbld', 01:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:46 INFO - 'XPC_FLAGS': '0x0', 01:28:46 INFO - 'XPC_SERVICE_NAME': '0', 01:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-NyozpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-RotO0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-_Kq6tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-sRHxXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MtCd5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-T2VUbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:46 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)) 01:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-FebKwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-N5AazO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-f5XpzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-58_xmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MC4wOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Er4WaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ausxGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-VpWz94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-d13Vdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:47 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)) 01:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-9FY8Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:48 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)) 01:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:48 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-t5EloW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:48 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)) 01:28:48 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)) 01:28:48 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)) 01:28:48 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)) 01:28:48 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)) 01:28:48 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)) 01:28:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:28:48 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 01:28:48 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 01:28:48 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 01:28:48 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 01:28:48 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 01:28:48 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 01:28:50 INFO - Downloading blessings-1.6.tar.gz 01:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:28:50 INFO - Installing collected packages: blessings 01:28:50 INFO - Running setup.py install for blessings 01:28:50 INFO - Successfully installed blessings 01:28:50 INFO - Cleaning up... 01:28:50 INFO - Return code: 0 01:28:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:51 INFO - Reading from file tmpfile_stdout 01:28:51 INFO - Current package versions: 01:28:51 INFO - blessings == 1.6 01:28:51 INFO - blobuploader == 1.2.4 01:28:51 INFO - docopt == 0.6.1 01:28:51 INFO - manifestparser == 1.1 01:28:51 INFO - mozInstall == 1.12 01:28:51 INFO - mozcrash == 0.17 01:28:51 INFO - mozdebug == 0.1 01:28:51 INFO - mozdevice == 0.48 01:28:51 INFO - mozfile == 1.2 01:28:51 INFO - mozhttpd == 0.7 01:28:51 INFO - mozinfo == 0.9 01:28:51 INFO - mozleak == 0.1 01:28:51 INFO - mozlog == 3.1 01:28:51 INFO - moznetwork == 0.27 01:28:51 INFO - mozprocess == 0.22 01:28:51 INFO - mozprofile == 0.28 01:28:51 INFO - mozrunner == 6.11 01:28:51 INFO - mozscreenshot == 0.1 01:28:51 INFO - mozsystemmonitor == 0.0 01:28:51 INFO - moztest == 0.7 01:28:51 INFO - mozversion == 1.4 01:28:51 INFO - psutil == 3.1.1 01:28:51 INFO - requests == 1.2.3 01:28:51 INFO - wsgiref == 0.1.2 01:28:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:51 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 01:28:51 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 01:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:51 INFO - 'HOME': '/Users/cltbld', 01:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:51 INFO - 'LOGNAME': 'cltbld', 01:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:51 INFO - 'MOZ_NO_REMOTE': '1', 01:28:51 INFO - 'NO_EM_RESTART': '1', 01:28:51 INFO - 'PAGER': '/bin/cat', 01:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:51 INFO - 'PWD': '/builds/slave/test', 01:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:51 INFO - 'SHELL': '/bin/bash', 01:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:51 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:51 INFO - 'USER': 'cltbld', 01:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:51 INFO - 'XPC_FLAGS': '0x0', 01:28:51 INFO - 'XPC_SERVICE_NAME': '0', 01:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 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)) 01:28:51 INFO - Cleaning up... 01:28:51 INFO - Return code: 0 01:28:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 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 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:51 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 01:28:51 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 01:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:51 INFO - 'HOME': '/Users/cltbld', 01:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:51 INFO - 'LOGNAME': 'cltbld', 01:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:51 INFO - 'MOZ_NO_REMOTE': '1', 01:28:51 INFO - 'NO_EM_RESTART': '1', 01:28:51 INFO - 'PAGER': '/bin/cat', 01:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:51 INFO - 'PWD': '/builds/slave/test', 01:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:51 INFO - 'SHELL': '/bin/bash', 01:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:51 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:51 INFO - 'USER': 'cltbld', 01:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:51 INFO - 'XPC_FLAGS': '0x0', 01:28:51 INFO - 'XPC_SERVICE_NAME': '0', 01:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:51 INFO - Downloading/unpacking jsonschema 01:28:51 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 01:28:51 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 01:28:51 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 01:28:51 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 01:28:51 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 01:28:51 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 01:28:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:28:54 INFO - Downloading/unpacking functools32 (from jsonschema) 01:28:54 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 01:28:54 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 01:28:54 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 01:28:54 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 01:28:54 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 01:28:54 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 01:28:54 INFO - Downloading functools32-3.2.3-2.tar.gz 01:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:28:54 INFO - warning: no files found matching '*.txt' 01:28:54 INFO - no previously-included directories found matching 'build' 01:28:54 INFO - no previously-included directories found matching 'dist' 01:28:54 INFO - no previously-included directories found matching '.git*' 01:28:54 INFO - Installing collected packages: jsonschema, functools32 01:28:54 INFO - Running setup.py install for functools32 01:28:54 INFO - warning: no files found matching '*.txt' 01:28:54 INFO - no previously-included directories found matching 'build' 01:28:54 INFO - no previously-included directories found matching 'dist' 01:28:54 INFO - no previously-included directories found matching '.git*' 01:28:54 INFO - Successfully installed jsonschema functools32 01:28:54 INFO - Cleaning up... 01:28:54 INFO - Return code: 0 01:28:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10677fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8901c7d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, '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.QQHSF1aJZb/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.QOr8jeejzv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 01:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:54 INFO - 'HOME': '/Users/cltbld', 01:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:54 INFO - 'LOGNAME': 'cltbld', 01:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:54 INFO - 'MOZ_NO_REMOTE': '1', 01:28:54 INFO - 'NO_EM_RESTART': '1', 01:28:54 INFO - 'PAGER': '/bin/cat', 01:28:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:54 INFO - 'PWD': '/builds/slave/test', 01:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:54 INFO - 'SHELL': '/bin/bash', 01:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:28:54 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:54 INFO - 'USER': 'cltbld', 01:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:54 INFO - 'XPC_FLAGS': '0x0', 01:28:54 INFO - 'XPC_SERVICE_NAME': '0', 01:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:55 INFO - Downloading/unpacking flake8 01:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:28:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:28:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:28:58 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 01:28:58 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 01:28:58 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 01:28:58 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 01:28:58 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 01:28:58 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 01:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:58 INFO - no previously-included directories found matching 'docs/_build' 01:28:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:28:58 INFO - Running setup.py install for pep8 01:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:58 INFO - no previously-included directories found matching 'docs/_build' 01:28:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:28:59 INFO - Cleaning up... 01:28:59 INFO - Return code: 0 01:28:59 INFO - Running post-action listener: _resource_record_post_action 01:28:59 INFO - Running post-action listener: _start_resource_monitoring 01:28:59 INFO - Starting resource monitoring. 01:28:59 INFO - ##### 01:28:59 INFO - ##### Running install step. 01:28:59 INFO - ##### 01:28:59 INFO - Running pre-action listener: _resource_record_pre_action 01:28:59 INFO - Running main action method: install 01:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:59 INFO - Reading from file tmpfile_stdout 01:28:59 INFO - Detecting whether we're running mozinstall >=1.0... 01:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:28:59 INFO - Reading from file tmpfile_stdout 01:28:59 INFO - Output received: 01:28:59 INFO - Usage: mozinstall [options] installer 01:28:59 INFO - Options: 01:28:59 INFO - -h, --help show this help message and exit 01:28:59 INFO - -d DEST, --destination=DEST 01:28:59 INFO - Directory to install application into. [default: 01:28:59 INFO - "/builds/slave/test"] 01:28:59 INFO - --app=APP Application being installed. [default: firefox] 01:28:59 INFO - mkdir: /builds/slave/test/build/application 01:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:29:31 INFO - Reading from file tmpfile_stdout 01:29:31 INFO - Output received: 01:29:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:29:31 INFO - Running post-action listener: _resource_record_post_action 01:29:31 INFO - ##### 01:29:31 INFO - ##### Running run-tests step. 01:29:31 INFO - ##### 01:29:31 INFO - Running pre-action listener: _resource_record_pre_action 01:29:31 INFO - Running main action method: run_tests 01:29:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:29:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:29:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:29:31 INFO - 2016-04-14 01:29:31.951 screenresolution[1929:15667] starting screenresolution argv=screenresolution get 01:29:31 INFO - 2016-04-14 01:29:31.954 screenresolution[1929:15667] Display 0: 1600x1200x32@60 01:29:31 INFO - 2016-04-14 01:29:31.959 screenresolution[1930:15670] starting screenresolution argv=screenresolution list 01:29:31 INFO - Available Modes on Display 0 01:29:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:29:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:29:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:29:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:29:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:29:32 INFO - Intel Iris: 01:29:32 INFO - Chipset Model: Intel Iris 01:29:32 INFO - Type: GPU 01:29:32 INFO - Bus: Built-In 01:29:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:29:32 INFO - Vendor: Intel (0x8086) 01:29:32 INFO - Device ID: 0x0a2e 01:29:32 INFO - Revision ID: 0x0009 01:29:32 INFO - Displays: 01:29:32 INFO - Display: 01:29:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:29:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:29:32 INFO - Display Serial Number: 1600x1200 60 01:29:32 INFO - Main Display: Yes 01:29:32 INFO - Mirror: Off 01:29:32 INFO - Online: Yes 01:29:32 INFO - Rotation: Supported 01:29:32 INFO - Return code: 0 01:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:29:32 INFO - Python 2.7.3 01:29:32 INFO - Return code: 0 01:29:32 INFO - grabbing minidump binary from tooltool 01:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:32 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 0x106623d30>, '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 0x106487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10661ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:29:32 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 01:29:32 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 01:29:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:29:32 INFO - Return code: 0 01:29:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:29:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:29:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:29:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:29:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:29:33 INFO - Return code: 0 01:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 01:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --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 01:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QQHSF1aJZb/Render', 01:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:33 INFO - 'HOME': '/Users/cltbld', 01:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:33 INFO - 'LOGNAME': 'cltbld', 01:29:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:29:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:33 INFO - 'MOZ_NO_REMOTE': '1', 01:29:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:29:33 INFO - 'NO_EM_RESTART': '1', 01:29:33 INFO - 'PAGER': '/bin/cat', 01:29:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:33 INFO - 'PWD': '/builds/slave/test', 01:29:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:33 INFO - 'SHELL': '/bin/bash', 01:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QOr8jeejzv/Listeners', 01:29:33 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 01:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:33 INFO - 'USER': 'cltbld', 01:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:33 INFO - 'XPC_FLAGS': '0x0', 01:29:33 INFO - 'XPC_SERVICE_NAME': '0', 01:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 01:29:33 INFO - mozversion application_buildid: 20160413234048 01:29:33 INFO - mozversion application_changeset: 7d39fe1e571c9bd656d66e05732ebd11419c5e77 01:29:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:29:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:29:33 INFO - mozversion application_name: Firefox 01:29:33 INFO - mozversion application_remotingname: firefox-dev 01:29:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:29:33 INFO - mozversion application_vendor: Mozilla 01:29:33 INFO - mozversion application_version: 47.0a2 01:29:33 INFO - mozversion platform_buildid: 20160413234048 01:29:33 INFO - mozversion platform_changeset: 7d39fe1e571c9bd656d66e05732ebd11419c5e77 01:29:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:29:33 INFO - mozversion platform_version: 47.0a2 01:29:33 INFO - using testdate: 1460622573 01:29:33 INFO - actual date: 1460622573 01:29:33 INFO - starting webserver on 'localhost:52272' 01:29:33 INFO - SUITE-START | Running 2 tests 01:29:33 INFO - TEST-START | dromaeo_css 01:29:33 INFO - operating with platform_type : mac_ 01:29:33 INFO - Initialising browser for dromaeo_css test... 01:29:33 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpoBcsbU/profile http://localhost:52272/getInfo.html) 01:29:35 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 01:29:35 INFO - PROCESS | 1948 | colorDepth:24 01:29:35 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 01:29:35 INFO - PROCESS | 1948 | __metrics 01:29:36 INFO - PROCESS | 1948 | 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" 01:29:36 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:29:36 INFO - TEST-INFO | 1948: exit 0 01:29:36 INFO - Browser initialized. 01:29:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:29:36 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpoBcsbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:29:48 INFO - PROCESS | 1950 | RSS: Main: 207667200 01:29:48 INFO - PROCESS | 1950 | 01:30:39 INFO - PROCESS | 1950 | 1460622639952 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] 01:32:50 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52272/tests/dromaeo/cssquery-ext.html) 01:32:51 INFO - PROCESS | 1950 | RSS: Main: 323469312 01:32:51 INFO - PROCESS | 1950 | 01:35:54 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-ext.html (next: http://localhost:52272/tests/dromaeo/cssquery-jquery.html) 01:35:54 INFO - PROCESS | 1950 | RSS: Main: 343666688 01:35:54 INFO - PROCESS | 1950 | 01:38:56 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52272/tests/dromaeo/cssquery-mootools.html) 01:38:57 INFO - PROCESS | 1950 | RSS: Main: 350818304 01:38:57 INFO - PROCESS | 1950 | 01:41:59 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52272/tests/dromaeo/cssquery-prototype.html) 01:41:59 INFO - PROCESS | 1950 | RSS: Main: 307519488 01:41:59 INFO - PROCESS | 1950 | 01:45:02 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52272/tests/dromaeo/cssquery-yui.html) 01:45:03 INFO - PROCESS | 1950 | RSS: Main: 307347456 01:45:03 INFO - PROCESS | 1950 | 01:48:05 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-yui.html (next: http://localhost:52272/tests/dromaeo/cssquery-dojo.html) 01:48:06 INFO - PROCESS | 1950 | RSS: Main: 355733504 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | __start_tp_report 01:48:06 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 01:48:06 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 01:48:06 INFO - PROCESS | 1950 | |i|pagename|runs| 01:48:06 INFO - PROCESS | 1950 | |0;dojo.html;3003.864826082826;3391.8812841550543;3439.6732310430516;3502.317048175606;3532.417151170057;5747.28158980127;5749.741261643226;5753.993051216042;5791.333996590393;5815.1277308403705;5731.168980497825;5773.769049238036;5794.884102317962;5816.418358164182;5817.127430885359;5123.743812809364;5147.51098645629;5192.273081768555;5196.402413722413;5280.762365693553;5254.369475662926;5269.6311258211945;5269.710165940872;5270.947290527103;5272.789088436458;5186.273921650972;5253.816116435925;5253.8949221015555;5291;5311.707856067915;5225.242339860718;5259.132243179871;5280.1815718563685;5286.02208591408;5305.177697456862;5002.799888004475;5170.276161337416;5175.0943584872875;5186.5850731941355;5188.22176673502;5607.859803504904;5617.9719101404235;5625.887482250373;5631.155326700987;5659.264295641581;6103.176071230371;6250.812475625738;6257.374262573751;6263.749450021994;6267.5299352548745;6169.074638804171;6207.162033125561;6215.968920155416;6235.906461403082;6240.31356550779;5785.566082543826;5853.443922827325;5868.178455016301;5884.293884733816;5894.233749612523;6233.781817636452;6241.34465881085;6249.125122482856;6258.43674069336;6264.5301602379095;6068;6070.423309785563;6137.171481849982;6142.3550527194;6146.385361463817;6135.508280839725;6246.593971391845;6248.687565621701;6252.531060170505;6256.061590761331;6135.07973803933;6242.1261023456755;6246.281677607042;6254.405831446005;6259.1550140730415;6116.701002199504;6166.075088736726;6223.159873417031;6274.2784579773;6276.309605943343;4917.582005529499;4938.234573641092;4941.061198372369;4942.975285123552;4945.727984960789;3783;4325.84859529915;4340.500842403101;4435.933460998088;4436.977815110969;5745.310562732415;5760.049591817303;5767.682777447197;5767.913481297784;5810.4770570648;6196.690165491707;6223.1287619733275;6243.188385509855;6254.34329395416;6256.5307601930035;5645.294338207724;5738.856528586819;5749.741261643236;5763.538916886639;5766.163906233656;5296.7351632418995;5318;5318.813841515605;5331.546818520392;5369.3556773187465;6254.655993920287;6293.937060629427;6311.053341998737;6314.55798094129;6321.399467050623;5140.845774626767;6142.447179753844;6214;6230.875382492415;6246.843828904132;6209.534284928739;6280.214973128359;6301.558890877594;6307.463865571478;6310.368963103653;5116.590672746246;6151.96924015395;6152.969235153795;6164.722587483484;6167.982282923447;6119.99004232014;6137.376985335611;6186.381361863778;6191.380861913773;6232.594881332699;6094.08036468511;6143.634700640197;6154.261488621215;6160.13758073861;6172.814815555361;6107.53030159963;6134.724336736039;6135.569531795875;6145.525073982301;6149.139120523041;5848.298204215522;5908.586398952032;5966.254218222723;6003.769137822133;6044.304904935989;6102.328743838086;6128.525473180255;6131.842101317736;6135.355787642234;6141.6007959482495;5843.181954526284;6010;6020.187274717857;6026.096085587197;6031.487323577545 01:48:06 INFO - PROCESS | 1950 | |1;ext.html;458.0404053507904;578.8089930322993;600.2976517474557;656.7274581048865;659.9505037122216;27820.443591128165;32406.351872962558;32429.837850810713;37004.81497592515;40124.79937600308;43827.561724382744;44433.8891527712;44609.330860037124;44611.33083003757;44744;9762.26782991275;9993.600255989788;9994.600215991351;9997;10028.498575071217;9794.167495762833;9903.653372131977;9908.752281192956;9916.851247231261;9925.354851934637;10017.148542373907;10068.395896246213;10100.141487973495;10109.090181883628;10109.292349535535;9985.500724963758;10066.446345450997;10067.29528932975;10072.899271007269;10075.34510256831;9782.364146330467;9920.801583968352;9923.503824808802;9928.205743540499;9932.503374831229;42851;43255.35116973248;43267.56732432667;43284.18652787559;43321.35017974733;3214.9357012859614;3227.919302017445;3309.3050459403553;3427.417339052367;3851.9229615407817;29599.70400295991;29896.701032989607;29953;30130;30300.54549181764;2711.9050833220745;2757.7518023377993;2794.748472637452;2812.395335002984;2823.774098072149;478874;480129;481200.5939970313;482141;482597;72746.63626681833;73077.6346118266;73212.63393682998;73243.63378183075;73283.26716732871;77334;80816.59591702004;82065.58967205125;82084.17915820885;82113.58943205245;18978.52553686169;19047.42857714271;19167.904160479386;19199;19228.807711922982;14223.359948802328;14295.78556321656;14303.499377521737;14315.069520481135;14330.211838348783;23760;23906.402339941294;24061.75938240595;24117.75882241155;24190.87904560466;8888.266787976412;9044.683436079706;9053.818923621491;9065.546722663972;9070.773230669154;1026.7741096958657;1065.8667666541528;1075.7955988362187;1078.687180717583;1175.8118701007968;30910.53634195489;30924.845375772977;31074.378512430078;31356.24822867793;31363.84318078395;1024.5645600619855;1130.6947124276398;1132.3206076354122;1138.635636596298;1156.7744289863397;13624;15688.686226275411;15830;16074.254715572448;16152.515424537283;524881;761504;768520;769262;769991;61303;61469;62242.755144897754;62284.68857655773;62341.376586234466;1411.181514721459;1447.261896432827;1535.884808639379;1571.6483823911426;1574.3623832347917;30168.94408695685;32195.712171513813;32635.673643264214;32915.670843291264;33026.83486582552;58762;59075.704621476616;59276.70361648337;59386.812263755346;59499;499628;503351;503655;503867;505515;38283.61716382912;46302.536974629824;46904.06191876212;47076.52923470722;47174.05651886875;45948.770256148506;46019.76990115028;46022.76988615035;46273.3059004122;47710.76144619255;36834.44748328724;37844.432333514465;37935.05162370963;38232.8703198065;39577;36277.45583816192;36632.45051324179;38698.839034829;39168;39457.80271098626;38614.80692596632;39286.80356598199;39299.803500982314;39416.2116757669;39450;34150.31699366048;34457;34988;35103.47344789881;35206.47190292199;22335.553288934454;25951.091711790752;26136.8693156533;26198.73801261963;26648.733512664625 01:48:06 INFO - PROCESS | 1950 | |2;jquery.html;325.58000179768095;355.56798489834875;377.1551724137931;377.7318104146056;382.1478103828463;19702.90148549257;20452.07965641544;20735;20884.582308353823;20907.954602269903;11936.925676689096;12300.077494187926;12309.015278777699;12314.384280785947;12321.938390308058;5254.973725131369;5441.2654291670715;5460.863478413052;6120.724567394478;6131.3868613138775;6040.426159514839;6063.939360606404;6086.421789929972;6099.329073801879;6108.908366374508;6078.361772013919;6290.528210384216;6448.838779030539;6560.803175904731;6572.441342485894;6466.805995820133;6574.079628851964;6594.967025164891;6598.406143447089;6599.703013364386;5662.915056274159;5756.453136951983;5778.075507918713;5787.13193021046;5787.421257874179;13638.386272617756;13982.161070335711;14142.505012324622;14160.787588186186;14166.787498187536;2091.5816836632735;2147.226998280618;2233.1737257214772;2302.067662596651;2371.063429945162;9963.302568820185;10067.395956242648;10447.68656940293;12209.511619535208;15368.615784605363;1732.3417101501475;1747.2312182639598;1755.4996825904684;1795.3446991848011;1809.6471188118321;117052;117979;121115.39442302732;121469;122202;11506.482208300478;11527;11534.19260651763;11567.315237328896;11718.355490448108;12199.695007624703;14528.927355363367;14663.56009319722;14675;14694.55916322512;7513.2862378074;8739.60671769772;8938.910610893938;8977.506237157018;9021;9037.77405564853;9066.773330666787;9070.319726020574;9163.908360916439;9170.67902623405;4169.437125988014;4483.50681425043;4485.596296333346;4517.909641807146;4545.36364908913;1557.0190779808647;1682.5541231573643;1878.445858471754;1901.3250296144945;1904.8571357147991;916.1434059154711;973.6300205921705;992.7418871093568;1026.3687831983425;1047.554789214596;20812;21023.474413139793;21050.894745526173;21158.153673852874;21230.893845530674;974.541965276319;988.5353883674661;1018;1039.194624166262;1040.6877936618985;10991.945040274748;11345.489452974636;11350.716232094099;11374.260673056226;11415.42922853854;546454;622990;636748;644468.5553144502;650998;122640;124111;127472;127620;127827;1056.3978532236551;1063.181350360203;1091.6561283195767;1108.5177947592663;1109.9334039957628;17966.640667186846;18744.812551874853;18828;18855.622887541896;19074.523136921132;51386;52275.73862130665;52986.2052069227;53145.734271328394;53757.46242537525;78118.6094069526;78249.60875195588;78944;79638.6018069906;79895.20104798878;8230.135835737161;8233.17668233172;8329.791755206168;8382.287505562095;8605.569721514024;9405.623775048922;11522.308661480003;12862.742745145231;13507.324633768469;13948.58154255374;8857.468551886908;11422.31466112036;11664.825027624762;11840.934315911609;12047.698807529881;11444.198906076495;11561.768764624492;11754.353510557;11924.284542927453;12016.75966480683;11714.648560543197;11763.058955283386;12023.579174729193;12054.698632534257;12057.095717821374;8235.95882020586;8245.093039765741;8304.501729896225;8370.121137280741;8624.741257762276;11446.084313254752;11729.296242225493;11949.22330048544;11950.760984780429;11960.282383057045 01:48:06 INFO - PROCESS | 1950 | |3;mootools.html;1365.9180449173043;1640.466848274311;1671.6322409070008;2027.8276346510545;2102.0645812613384;7303.379212766915;7808.453408261417;9034.277257819374;9035.72892813215;9039.186473217409;8670.609822557984;8974.641014359435;8981.910180898189;8982.955085224581;8995.415298005624;2261.3442101790542;2477.009196321477;2524.7475252474787;2531.493701259746;2554.9872250638723;2551.0051080078783;2560.2447278052928;2562.6027965665353;2562.6540417043648;2562.8334158279745;2122.2678176029244;2454.3005243505604;2537.5305568469894;2542.5677634802128;2545.9490810183784;2217.9001944912357;2395.3293077938206;2519.5842685956795;2520.596704527267;2529.3170843872144;2099.296735593578;2107.4099252209407;2460.7047154341594;2513.258588716333;2526.886290116931;9065.320100992452;9143.405678630868;9161.358704890661;9164.991850896396;9182.357234993553;5556.86107847303;5643.6049476536655;5661.5187709044785;5672.461116193955;5750.741216645261;3603.621619729943;3659.1035196377056;3733.4213196954515;3740.551133863954;3759.548854137521;1060.5015642647943;1069.059227879461;1079;1082.1667316166586;1104.469854469859;12339.5064197432;12356.62930112098;12366;12366.44351004207;12372.876271237263;4405.361222622766;4909.2881532177635;4920.458749537548;4935.777889994959;5036.64743467961;9679.274054445805;9686.225101991824;10436.791264174673;10438.269321147598;10457.267991240693;5645.379008309083;5647.802326918621;5658.91511627326;5661.716914154275;5688.146777983253;4548.0221752323405;4674.0651869625535;4855.5387238212315;5021;5025.748712564357;3931.68546516278;3989.940150897739;4010.7593544387432;4029.7985100744845;4047.817848196838;1327.2965328375976;1342.3489607540334;1345.2466618693563;1348.6695759538975;1350.473315406992;1398.2309729648653;1405.4237762517319;1447.3776276201124;1448.2396741710686;1450.1226757811583;8352.707655232038;8369.83260334802;8434.493930364199;8500.277476414574;8519;519.828456609318;529.9258103865462;530.4986787485866;533.2933862632028;534.3267482971484;5276.868078298074;6278.560500764994;6342.968285158545;6355.904661430082;6359.3640635936035;10627.309224900357;10965.83551246732;10969;10973.3964631946;10999.61501347465;9204;10729.302595331279;10828.022313733396;10884.183686223407;10956.835647465294;8549;8566.18621230982;8618.439801412887;8620.827583448421;8635.179657932485;8044.477108987897;8074.273315401642;8123.593820308843;8125.146859579895;8155.714549990722;9600.087991640783;9859.802803943738;9891.653792117242;9947.701568952943;9966.252531060054;10069.144122749649;10210.489475526343;10324.07083362501;10362.378257304586;10367.377957322586;6738.460923126237;6961.930380696128;7174.569525828467;7596.240375962359;7677.9232207677205;6647.5014373921185;8346.749597512084;8398.286145677686;8430.156984301766;8721.781955451164;6386.137871387489;7240.818979525554;7381.7416390428225;7424.480286379901;7506;7332.743353982798;7367.742129025459;7377.963110184414;7390.076240469942;7472.813179670552;7790.415718821225;7869.606519674108;7876.763697089096;7879.724209652634;7885.763427097197;7064.964675176591;7071.080759501232;7153.928460715326;7154.105736782903;7156.354038571262;7257.637118144177;7320.341169294789;7339.082614673166;7344.339009489172;7345.889811652936 01:48:06 INFO - PROCESS | 1950 | |4;prototype.html;322.4051624752333;331.68489934562166;340.526667931575;340.95908490981077;342.42814499785356;6689.933100668992;6725.361090696389;6728.831779205516;6786.694598743056;6789.3889549940495;5348.866278343044;6677.298883617211;6685.532012759097;6686.765963191289;6689.498287628423;4727.858164255061;4816.277558366256;4850.320955066293;4915.5821755150855;4965.131102057144;4933.260010998361;4948.183549714293;4948.7773050212645;4954.455009948902;4966.453690094087;4086.4483294755273;4583.739471645291;4906.141425250585;4907.975460122712;4927.778249978742;4183.3097538906195;4758.690685105457;4891.5353041461;4896.779644915988;4897.559219670211;4197.370394440828;4208.3687446882905;4209.6000879916355;4213.936790948138;4217;6289.7169627366875;6386.10594516768;6420.0690899819265;6447.871042579122;6453.032045193212;5886.293644762613;5887.381824908366;5891.175235467038;5893.970530147321;5896.262967129109;6784.559003664746;7080.398166155883;7082.858342833115;7092.645367731644;7093.219745827955;4614.330922016289;4621.145088158702;4637.2116740153915;4659.464161621389;4660.883477913046;6478.222613286436;7199.6040217788;7563.584002879839;7568.356689681384;7588.089429268523;4707.7175369477945;4718.150732868048;4728.881777955578;4732.574068333797;4734.337192793012;4800.879978000508;4805.7597120143855;4809.134355815987;4809.158397280462;4812.398450193726;5577.27495425592;5742.598018138774;5742.827715168552;5743.655380677173;5753.108268218432;6511.413972742381;6673.499487538454;7158.176809666851;7176.7846964591145;7177.246389129171;1614.0799744145725;1655.6854197702398;1658.8589969852455;1661.6261341198376;1664.1097013097935;989.7030890732751;1017.3234798858676;1043.3426941027255;1045.137761346892;1071.1912506057877;5171.844844654666;6630.336966303427;6662.700178491979;6774.898376524356;6820.965895170492;7472.364848987788;7473.215312392229;7478.775636730907;7484.476086673881;7491.138519070377;6768.255491895888;6788.389044985975;6794.592324460548;6806.659667016629;6807.4894382921475;3781.4327850822597;3874.380099184117;3921;3924.803759811998;3927.7839718815167;6269.780557680459;6705.4970877184405;7742.4580279381025;7771.184025677222;7784.610769461618;7584.469087163846;7671.693132274647;7676.040494938133;7685.4620176587105;7785.92214077852;7010.719571217196;7759.68961241544;7761.61191940412;7776.300132987945;7782.766517004499;7168.24733403006;7401.481896267425;7412.888806667796;7413.629318534159;7423.851522969619;7287.578922110138;7319;7333.1200255969625;7336.266373362621;7336.633168341455;7743.728969486041;7750.341220996278;7760.3403710685225;7769.300762931363;7794.181610930771;4726.787294571684;4748.311494833299;4752.976235118802;4754.595859351994;4764.666473346832;5647.5481961442165;6419.807405777834;7145.035420218204;7373;7384.224656411215;7151.821204469722;7185.748498802517;7193.712251509881;7196.3163499469565;7199.568025918462;6482.092507048923;6546.639934803441;7150.928490715234;7170.2471240519;7183.820404489929;6992.0560724303605;7003.824904377431;7008.264132266243;7011.964940175267;7013.509054366145;6968.128983877015;7129.21578626361;7163.176234733072;7175.354218120394;7181.892271616034;6685.598864068172;6835.93164068353;6839;6948.687309071003;7006 01:48:06 INFO - PROCESS | 1950 | |5;yui.html;662.2549631664377;663.9369259920306;671.9294474080222;716.9247229040953;726.4987158860386;12661;15175.08949463033;15234.847651523482;15244.618884527892;15307.846921530781;14339.42642294307;14565.27173641319;14573.92713036436;14574;14574.344154513046;778.105179044101;787.7479206653844;941.7221919533737;961.7835986902926;988.4365911430488;975.7755716185246;978.2711879649636;981.6515137126324;982.6855406269997;983.8917719050899;1030.8350663893777;1032.9328593641426;1033.689893032091;1033.8087453821067;1037.4086770540796;811.0834756724893;1012.3369193178443;1031.8813336466328;1032.4837581209395;1034.818906691326;761.4213197969527;762.2263402646319;763.3435245688703;763.8968739220189;766.0309708219107;15547.689046219126;15604.29780659873;15621.92189039059;15639.843601564065;15665.530034098996;12982.545610903573;12998.675033124153;13160.14459060158;13216.273104979222;13583.539910758553;10076.907710747133;10115.797684046278;10154.9492252539;10500.474976251233;10558.155347572176;3524.682778549917;3539.50446937429;3570.4465807799575;3620.8913732588067;3766.9623303766884;83510.58244708799;85416.14583854144;85645.57177214137;85663;86426;9682.79470943162;9803.264755143393;9881.110700037032;10037.046480584333;10102.797944041078;23665.408364790674;23741.931613077453;23749.762502375102;23773;23784.762152378255;7354.558726476428;7417;7488.588127653032;7655.0813902332075;7737.92262077372;4044.4742183515955;4132.111596006813;4208.074223670787;4249.68127390447;4410.095930334273;3718.7025037996896;3749.49381833449;3758.9060273493383;3762.811859407019;3763.2285381496727;624.8687775567091;637.7990932856228;640.5996252342286;653.6143675231637;653.8888388973886;557.9191017302469;610.081826850587;610.8259146143328;612.7395856760859;616.3559080760616;7572.7728168155045;8109.716159934492;8250.339972802161;8294.40242510058;8516.70191543293;582.7377680043998;598.5720210049835;602.1900543768625;609.5641616244407;617.9165812615329;3662.406853018945;3833.0225792422752;3860.8069596520063;3886.436466712311;3893.6885049196;99672.5016374928;101532;101604.49197754111;101786;101957.49021254995;61055.99999999911;85605;86323;87065;88895.55552222327;54325.72837135868;71223;74131;75959.62020189864;76889.84665230026;6340.397662222082;7766.417518686008;7808.9609551954145;7812.023497062867;7832.334251588451;45018.549814501435;50982.49017509777;52117.47882521278;53045.4695453056;53844.73077634744;63207;69980;72813.63593182;73948.63025684837;74726.62636686781;9930.413385336467;10140;10182.643607473703;10210.591576337161;10483.318584291997;10192.592296308065;10408.47957602132;10515.369077855354;10526;10855.67432977012;10030.598776048877;10045.196384289386;10181.440020798631;10298.330608510423;10403.115735162293;8737.21365077146;10030.247731420026;10056.396616203052;10320.380777153396;10681.305715128492;9870.457124857914;9967.202623790225;9987.60049598008;10120.493975301353;10170.644027459004;8545.615447304763;8628.654853805778;8760.38866861702;8793.648254069765;8893.110688931056;8788.516631585324;8821.955890220508;8839.381243313164;8865.468071915706;8945.15021072997 01:48:06 INFO - PROCESS | 1950 | __end_tp_report 01:48:06 INFO - PROCESS | 1950 | __start_cc_report 01:48:06 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,1004 01:48:06 INFO - PROCESS | 1950 | __end_cc_report 01:48:06 INFO - PROCESS | 1950 | __startTimestamp1460623686181__endTimestamp 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | ------- Summary: start ------- 01:48:06 INFO - PROCESS | 1950 | Number of tests: 6 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5737.39 Median:6010.00 stddev:647.21 (10.8%) stddev-sans-first:612.64 01:48:06 INFO - PROCESS | 1950 | Values: 3003.9 3391.9 3439.7 3502.3 3532.4 5747.3 5749.7 5754.0 5791.3 5815.1 5731.2 5773.8 5794.9 5816.4 5817.1 5123.7 5147.5 5192.3 5196.4 5280.8 5254.4 5269.6 5269.7 5270.9 5272.8 5186.3 5253.8 5253.9 5291.0 5311.7 5225.2 5259.1 5280.2 5286.0 5305.2 5002.8 5170.3 5175.1 5186.6 5188.2 5607.9 5618.0 5625.9 5631.2 5659.3 6103.2 6250.8 6257.4 6263.7 6267.5 6169.1 6207.2 6216.0 6235.9 6240.3 5785.6 5853.4 5868.2 5884.3 5894.2 6233.8 6241.3 6249.1 6258.4 6264.5 6068.0 6070.4 6137.2 6142.4 6146.4 6135.5 6246.6 6248.7 6252.5 6256.1 6135.1 6242.1 6246.3 6254.4 6259.2 6116.7 6166.1 6223.2 6274.3 6276.3 4917.6 4938.2 4941.1 4943.0 4945.7 3783.0 4325.8 4340.5 4435.9 4437.0 5745.3 5760.0 5767.7 5767.9 5810.5 6196.7 6223.1 6243.2 6254.3 6256.5 5645.3 5738.9 5749.7 5763.5 5766.2 5296.7 5318.0 5318.8 5331.5 5369.4 6254.7 6293.9 6311.1 6314.6 6321.4 5140.8 6142.4 6214.0 6230.9 6246.8 6209.5 6280.2 6301.6 6307.5 6310.4 5116.6 6152.0 6153.0 6164.7 6168.0 6120.0 6137.4 6186.4 6191.4 6232.6 6094.1 6143.6 6154.3 6160.1 6172.8 6107.5 6134.7 6135.6 6145.5 6149.1 5848.3 5908.6 5966.3 6003.8 6044.3 6102.3 6128.5 6131.8 6135.4 6141.6 5843.2 6010.0 6020.2 6026.1 6031.5 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:72290.18 Median:21233.36 stddev:155190.45 (730.9%) stddev-sans-first:155532.09 01:48:06 INFO - PROCESS | 1950 | Values: 458.0 578.8 600.3 656.7 660.0 27820.4 32406.4 32429.8 37004.8 40124.8 43827.6 44433.9 44609.3 44611.3 44744.0 9762.3 9993.6 9994.6 9997.0 10028.5 9794.2 9903.7 9908.8 9916.9 9925.4 10017.1 10068.4 10100.1 10109.1 10109.3 9985.5 10066.4 10067.3 10072.9 10075.3 9782.4 9920.8 9923.5 9928.2 9932.5 42851.0 43255.4 43267.6 43284.2 43321.4 3214.9 3227.9 3309.3 3427.4 3851.9 29599.7 29896.7 29953.0 30130.0 30300.5 2711.9 2757.8 2794.7 2812.4 2823.8 478874.0 480129.0 481200.6 482141.0 482597.0 72746.6 73077.6 73212.6 73243.6 73283.3 77334.0 80816.6 82065.6 82084.2 82113.6 18978.5 19047.4 19167.9 19199.0 19228.8 14223.4 14295.8 14303.5 14315.1 14330.2 23760.0 23906.4 24061.8 24117.8 24190.9 8888.3 9044.7 9053.8 9065.5 9070.8 1026.8 1065.9 1075.8 1078.7 1175.8 30910.5 30924.8 31074.4 31356.2 31363.8 1024.6 1130.7 1132.3 1138.6 1156.8 13624.0 15688.7 15830.0 16074.3 16152.5 524881.0 761504.0 768520.0 769262.0 769991.0 61303.0 61469.0 62242.8 62284.7 62341.4 1411.2 1447.3 1535.9 1571.6 1574.4 30168.9 32195.7 32635.7 32915.7 33026.8 58762.0 59075.7 59276.7 59386.8 59499.0 499628.0 503351.0 503655.0 503867.0 505515.0 38283.6 46302.5 46904.1 47076.5 47174.1 45948.8 46019.8 46022.8 46273.3 47710.8 36834.4 37844.4 37935.1 38232.9 39577.0 36277.5 36632.5 38698.8 39168.0 39457.8 38614.8 39286.8 39299.8 39416.2 39450.0 34150.3 34457.0 34988.0 35103.5 35206.5 22335.6 25951.1 26136.9 26198.7 26648.7 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:35293.48 Median:20848.29 stddev:103577.75 (496.8%) stddev-sans-first:103835.03 01:48:06 INFO - PROCESS | 1950 | Values: 325.6 355.6 377.2 377.7 382.1 19702.9 20452.1 20735.0 20884.6 20908.0 11936.9 12300.1 12309.0 12314.4 12321.9 5255.0 5441.3 5460.9 6120.7 6131.4 6040.4 6063.9 6086.4 6099.3 6108.9 6078.4 6290.5 6448.8 6560.8 6572.4 6466.8 6574.1 6595.0 6598.4 6599.7 5662.9 5756.5 5778.1 5787.1 5787.4 13638.4 13982.2 14142.5 14160.8 14166.8 2091.6 2147.2 2233.2 2302.1 2371.1 9963.3 10067.4 10447.7 12209.5 15368.6 1732.3 1747.2 1755.5 1795.3 1809.6 117052.0 117979.0 121115.4 121469.0 122202.0 11506.5 11527.0 11534.2 11567.3 11718.4 12199.7 14528.9 14663.6 14675.0 14694.6 7513.3 8739.6 8938.9 8977.5 9021.0 9037.8 9066.8 9070.3 9163.9 9170.7 4169.4 4483.5 4485.6 4517.9 4545.4 1557.0 1682.6 1878.4 1901.3 1904.9 916.1 973.6 992.7 1026.4 1047.6 20812.0 21023.5 21050.9 21158.2 21230.9 974.5 988.5 1018.0 1039.2 1040.7 10991.9 11345.5 11350.7 11374.3 11415.4 546454.0 622990.0 636748.0 644468.6 650998.0 122640.0 124111.0 127472.0 127620.0 127827.0 1056.4 1063.2 1091.7 1108.5 1109.9 17966.6 18744.8 18828.0 18855.6 19074.5 51386.0 52275.7 52986.2 53145.7 53757.5 78118.6 78249.6 78944.0 79638.6 79895.2 8230.1 8233.2 8329.8 8382.3 8605.6 9405.6 11522.3 12862.7 13507.3 13948.6 8857.5 11422.3 11664.8 11840.9 12047.7 11444.2 11561.8 11754.4 11924.3 12016.8 11714.6 11763.1 12023.6 12054.7 12057.1 8236.0 8245.1 8304.5 8370.1 8624.7 11446.1 11729.3 11949.2 11950.8 11960.3 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:6141.93 Median:531.90 stddev:3275.83 (615.9%) stddev-sans-first:3265.35 01:48:06 INFO - PROCESS | 1950 | Values: 1365.9 1640.5 1671.6 2027.8 2102.1 7303.4 7808.5 9034.3 9035.7 9039.2 8670.6 8974.6 8981.9 8983.0 8995.4 2261.3 2477.0 2524.7 2531.5 2555.0 2551.0 2560.2 2562.6 2562.7 2562.8 2122.3 2454.3 2537.5 2542.6 2545.9 2217.9 2395.3 2519.6 2520.6 2529.3 2099.3 2107.4 2460.7 2513.3 2526.9 9065.3 9143.4 9161.4 9165.0 9182.4 5556.9 5643.6 5661.5 5672.5 5750.7 3603.6 3659.1 3733.4 3740.6 3759.5 1060.5 1069.1 1079.0 1082.2 1104.5 12339.5 12356.6 12366.0 12366.4 12372.9 4405.4 4909.3 4920.5 4935.8 5036.6 9679.3 9686.2 10436.8 10438.3 10457.3 5645.4 5647.8 5658.9 5661.7 5688.1 4548.0 4674.1 4855.5 5021.0 5025.7 3931.7 3989.9 4010.8 4029.8 4047.8 1327.3 1342.3 1345.2 1348.7 1350.5 1398.2 1405.4 1447.4 1448.2 1450.1 8352.7 8369.8 8434.5 8500.3 8519.0 519.8 529.9 530.5 533.3 534.3 5276.9 6278.6 6343.0 6355.9 6359.4 10627.3 10965.8 10969.0 10973.4 10999.6 9204.0 10729.3 10828.0 10884.2 10956.8 8549.0 8566.2 8618.4 8620.8 8635.2 8044.5 8074.3 8123.6 8125.1 8155.7 9600.1 9859.8 9891.7 9947.7 9966.3 10069.1 10210.5 10324.1 10362.4 10367.4 6738.5 6961.9 7174.6 7596.2 7677.9 6647.5 8346.7 8398.3 8430.2 8721.8 6386.1 7240.8 7381.7 7424.5 7506.0 7332.7 7367.7 7378.0 7390.1 7472.8 7790.4 7869.6 7876.8 7879.7 7885.8 7065.0 7071.1 7153.9 7154.1 7156.4 7257.6 7320.3 7339.1 7344.3 7345.9 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:5811.81 Median:6675.40 stddev:1858.99 (27.8%) stddev-sans-first:1817.97 01:48:06 INFO - PROCESS | 1950 | Values: 322.4 331.7 340.5 341.0 342.4 6689.9 6725.4 6728.8 6786.7 6789.4 5348.9 6677.3 6685.5 6686.8 6689.5 4727.9 4816.3 4850.3 4915.6 4965.1 4933.3 4948.2 4948.8 4954.5 4966.5 4086.4 4583.7 4906.1 4908.0 4927.8 4183.3 4758.7 4891.5 4896.8 4897.6 4197.4 4208.4 4209.6 4213.9 4217.0 6289.7 6386.1 6420.1 6447.9 6453.0 5886.3 5887.4 5891.2 5894.0 5896.3 6784.6 7080.4 7082.9 7092.6 7093.2 4614.3 4621.1 4637.2 4659.5 4660.9 6478.2 7199.6 7563.6 7568.4 7588.1 4707.7 4718.2 4728.9 4732.6 4734.3 4800.9 4805.8 4809.1 4809.2 4812.4 5577.3 5742.6 5742.8 5743.7 5753.1 6511.4 6673.5 7158.2 7176.8 7177.2 1614.1 1655.7 1658.9 1661.6 1664.1 989.7 1017.3 1043.3 1045.1 1071.2 5171.8 6630.3 6662.7 6774.9 6821.0 7472.4 7473.2 7478.8 7484.5 7491.1 6768.3 6788.4 6794.6 6806.7 6807.5 3781.4 3874.4 3921.0 3924.8 3927.8 6269.8 6705.5 7742.5 7771.2 7784.6 7584.5 7671.7 7676.0 7685.5 7785.9 7010.7 7759.7 7761.6 7776.3 7782.8 7168.2 7401.5 7412.9 7413.6 7423.9 7287.6 7319.0 7333.1 7336.3 7336.6 7743.7 7750.3 7760.3 7769.3 7794.2 4726.8 4748.3 4753.0 4754.6 4764.7 5647.5 6419.8 7145.0 7373.0 7384.2 7151.8 7185.7 7193.7 7196.3 7199.6 6482.1 6546.6 7150.9 7170.2 7183.8 6992.1 7003.8 7008.3 7012.0 7013.5 6968.1 7129.2 7163.2 7175.4 7181.9 6685.6 6835.9 6839.0 6948.7 7006.0 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:18807.51 Median:27441.82 stddev:27383.18 (99.8%) stddev-sans-first:27426.10 01:48:06 INFO - PROCESS | 1950 | Values: 662.3 663.9 671.9 716.9 726.5 12661.0 15175.1 15234.8 15244.6 15307.8 14339.4 14565.3 14573.9 14574.0 14574.3 778.1 787.7 941.7 961.8 988.4 975.8 978.3 981.7 982.7 983.9 1030.8 1032.9 1033.7 1033.8 1037.4 811.1 1012.3 1031.9 1032.5 1034.8 761.4 762.2 763.3 763.9 766.0 15547.7 15604.3 15621.9 15639.8 15665.5 12982.5 12998.7 13160.1 13216.3 13583.5 10076.9 10115.8 10154.9 10500.5 10558.2 3524.7 3539.5 3570.4 3620.9 3767.0 83510.6 85416.1 85645.6 85663.0 86426.0 9682.8 9803.3 9881.1 10037.0 10102.8 23665.4 23741.9 23749.8 23773.0 23784.8 7354.6 7417.0 7488.6 7655.1 7737.9 4044.5 4132.1 4208.1 4249.7 4410.1 3718.7 3749.5 3758.9 3762.8 3763.2 624.9 637.8 640.6 653.6 653.9 557.9 610.1 610.8 612.7 616.4 7572.8 8109.7 8250.3 8294.4 8516.7 582.7 598.6 602.2 609.6 617.9 3662.4 3833.0 3860.8 3886.4 3893.7 99672.5 101532.0 101604.5 101786.0 101957.5 61056.0 85605.0 86323.0 87065.0 88895.6 54325.7 71223.0 74131.0 75959.6 76889.8 6340.4 7766.4 7809.0 7812.0 7832.3 45018.5 50982.5 52117.5 53045.5 53844.7 63207.0 69980.0 72813.6 73948.6 74726.6 9930.4 10140.0 10182.6 10210.6 10483.3 10192.6 10408.5 10515.4 10526.0 10855.7 10030.6 10045.2 10181.4 10298.3 10403.1 8737.2 10030.2 10056.4 10320.4 10681.3 9870.5 9967.2 9987.6 10120.5 10170.6 8545.6 8628.7 8760.4 8793.6 8893.1 8788.5 8822.0 8839.4 8865.5 8945.2 01:48:06 INFO - PROCESS | 1950 | -------- Summary: end -------- 01:48:06 INFO - PROCESS | 1950 | 01:48:06 INFO - TEST-INFO | 1950: exit 0 01:48:06 INFO - TEST-OK | dromaeo_css | took 1113064ms 01:48:06 INFO - TEST-START | kraken 01:48:06 INFO - operating with platform_type : mac_ 01:48:06 INFO - Initialising browser for kraken test... 01:48:06 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpdlP_Cc/profile http://localhost:52272/getInfo.html) 01:48:08 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 01:48:08 INFO - PROCESS | 1954 | colorDepth:24 01:48:08 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 01:48:08 INFO - PROCESS | 1954 | __metrics 01:48:08 INFO - PROCESS | 1954 | 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" 01:48:08 INFO - PROCESS | 1954 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:48:09 INFO - TEST-INFO | 1954: exit 0 01:48:09 INFO - Browser initialized. 01:48:09 INFO - Running cycle 1/1 for kraken test... 01:48:09 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpdlP_Cc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:21 INFO - PROCESS | 1956 | RSS: Main: 207839232 01:48:21 INFO - PROCESS | 1956 | 01:48:23 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-beat-detection) 01:48:24 INFO - PROCESS | 1956 | RSS: Main: 263237632 01:48:24 INFO - PROCESS | 1956 | 01:48:27 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-dft) 01:48:27 INFO - PROCESS | 1956 | RSS: Main: 273702912 01:48:27 INFO - PROCESS | 1956 | 01:48:30 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-fft) 01:48:31 INFO - PROCESS | 1956 | RSS: Main: 263548928 01:48:31 INFO - PROCESS | 1956 | 01:48:33 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-oscillator) 01:48:34 INFO - PROCESS | 1956 | RSS: Main: 265195520 01:48:34 INFO - PROCESS | 1956 | 01:48:36 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:48:36 INFO - PROCESS | 1956 | RSS: Main: 265687040 01:48:36 INFO - PROCESS | 1956 | 01:48:39 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-darkroom) 01:48:40 INFO - PROCESS | 1956 | RSS: Main: 265748480 01:48:40 INFO - PROCESS | 1956 | 01:48:42 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-desaturate) 01:48:43 INFO - PROCESS | 1956 | RSS: Main: 266350592 01:48:43 INFO - PROCESS | 1956 | 01:48:46 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52272/tests/kraken/driver.html?testName=json-parse-financial) 01:48:46 INFO - PROCESS | 1956 | RSS: Main: 266235904 01:48:46 INFO - PROCESS | 1956 | 01:48:48 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:48:48 INFO - PROCESS | 1956 | RSS: Main: 299663360 01:48:48 INFO - PROCESS | 1956 | 01:48:50 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:48:51 INFO - PROCESS | 1956 | RSS: Main: 300843008 01:48:51 INFO - PROCESS | 1956 | 01:48:53 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:48:54 INFO - PROCESS | 1956 | RSS: Main: 305979392 01:48:54 INFO - PROCESS | 1956 | 01:48:56 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:48:57 INFO - PROCESS | 1956 | RSS: Main: 307679232 01:48:57 INFO - PROCESS | 1956 | 01:48:59 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:49:00 INFO - PROCESS | 1956 | RSS: Main: 307798016 01:49:00 INFO - PROCESS | 1956 | 01:49:01 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52272/tests/kraken/driver.html?testName=ai-astar) 01:49:02 INFO - PROCESS | 1956 | RSS: Main: 370184192 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | __start_tp_report 01:49:02 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 01:49:02 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 01:49:02 INFO - PROCESS | 1956 | |i|pagename|runs| 01:49:02 INFO - PROCESS | 1956 | |0;ai-astar;111;111;109;108;109;110;119;109;108;109 01:49:02 INFO - PROCESS | 1956 | |1;audio-beat-detection;152;120;153;147;116;168;141;157;146;118 01:49:02 INFO - PROCESS | 1956 | |2;audio-dft;182;186;185;188;184;185;183;186;184;185 01:49:02 INFO - PROCESS | 1956 | |3;audio-fft;72;77;73;118;56;59;58;59;124;60 01:49:02 INFO - PROCESS | 1956 | |4;audio-oscillator;92;95;130;86;111;121;134;77;78;119 01:49:02 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;87;85;91;85;88;84;88;85;89;83 01:49:02 INFO - PROCESS | 1956 | |6;imaging-darkroom;93;92;94;95;93;93;94;94;93;93 01:49:02 INFO - PROCESS | 1956 | |7;imaging-desaturate;87;85;86;87;85;84;87;86;86;87 01:49:02 INFO - PROCESS | 1956 | |8;json-parse-financial;57;59;59;59;59;59;59;70;54;53 01:49:02 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;61;64;76;75;69;66;67;72;67;66 01:49:02 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;81;78;78;67;81;70;88;74;81;105 01:49:02 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;119;129;117;142;113;105;104;122;123;123 01:49:02 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;133;122;133;135;133;125;162;165;163;135 01:49:02 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;64;64;65;66;67;65;67;67;65;65 01:49:02 INFO - PROCESS | 1956 | __end_tp_report 01:49:02 INFO - PROCESS | 1956 | __start_cc_report 01:49:02 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1265 01:49:02 INFO - PROCESS | 1956 | __end_cc_report 01:49:02 INFO - PROCESS | 1956 | __startTimestamp1460623742191__endTimestamp 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | ------- Summary: start ------- 01:49:02 INFO - PROCESS | 1956 | Number of tests: 14 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:110.30 Median:109.50 stddev:3.23 (3.0%) stddev-sans-first:3.42 01:49:02 INFO - PROCESS | 1956 | Values: 111.0 111.0 109.0 108.0 109.0 110.0 119.0 109.0 108.0 109.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:149.50 stddev:17.95 (12.0%) stddev-sans-first:18.65 01:49:02 INFO - PROCESS | 1956 | Values: 152.0 120.0 153.0 147.0 116.0 168.0 141.0 157.0 146.0 118.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.69 (0.9%) stddev-sans-first:1.45 01:49:02 INFO - PROCESS | 1956 | Values: 182.0 186.0 185.0 188.0 184.0 185.0 183.0 186.0 184.0 185.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:75.60 Median:59.50 stddev:25.06 (42.1%) stddev-sans-first:26.54 01:49:02 INFO - PROCESS | 1956 | Values: 72.0 77.0 73.0 118.0 56.0 59.0 58.0 59.0 124.0 60.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:77.50 stddev:21.32 (27.5%) stddev-sans-first:22.15 01:49:02 INFO - PROCESS | 1956 | Values: 92.0 95.0 130.0 86.0 111.0 121.0 134.0 77.0 78.0 119.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:2.51 (2.9%) stddev-sans-first:2.65 01:49:02 INFO - PROCESS | 1956 | Values: 87.0 85.0 91.0 85.0 88.0 84.0 88.0 85.0 89.0 83.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 01:49:02 INFO - PROCESS | 1956 | Values: 93.0 92.0 94.0 95.0 93.0 93.0 94.0 94.0 93.0 93.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 01:49:02 INFO - PROCESS | 1956 | Values: 87.0 85.0 86.0 87.0 85.0 84.0 87.0 86.0 86.0 87.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:4.54 (7.7%) stddev-sans-first:4.77 01:49:02 INFO - PROCESS | 1956 | Values: 57.0 59.0 59.0 59.0 59.0 59.0 59.0 70.0 54.0 53.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:4.76 (7.0%) stddev-sans-first:4.26 01:49:02 INFO - PROCESS | 1956 | Values: 61.0 64.0 76.0 75.0 69.0 66.0 67.0 72.0 67.0 66.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.50 stddev:10.56 (13.3%) stddev-sans-first:11.20 01:49:02 INFO - PROCESS | 1956 | Values: 81.0 78.0 78.0 67.0 81.0 70.0 88.0 74.0 81.0 105.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:122.50 stddev:11.19 (9.1%) stddev-sans-first:11.86 01:49:02 INFO - PROCESS | 1956 | Values: 119.0 129.0 117.0 142.0 113.0 105.0 104.0 122.0 123.0 123.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:135.00 stddev:16.26 (12.0%) stddev-sans-first:17.02 01:49:02 INFO - PROCESS | 1956 | Values: 133.0 122.0 133.0 135.0 133.0 125.0 162.0 165.0 163.0 135.0 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.18 (1.8%) stddev-sans-first:1.12 01:49:02 INFO - PROCESS | 1956 | Values: 64.0 64.0 65.0 66.0 67.0 65.0 67.0 67.0 65.0 65.0 01:49:02 INFO - PROCESS | 1956 | -------- Summary: end -------- 01:49:02 INFO - PROCESS | 1956 | 01:49:02 INFO - TEST-INFO | 1956: exit 0 01:49:02 INFO - TEST-OK | kraken | took 56187ms 01:49:02 INFO - SUITE-END | took 1169s 01:49:03 INFO - Completed test suite (00:19:29) 01:49:03 INFO - javascript benchmark 01:49:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3003.864826082826, 3391.8812841550543, 3439.6732310430516, 3502.317048175606, 3532.417151170057, 5747.28158980127, 5749.741261643226, 5753.993051216042, 5791.333996590393, 5815.1277308403705, 5731.168980497825, 5773.769049238036, 5794.884102317962, 5816.418358164182, 5817.127430885359, 5123.743812809364, 5147.51098645629, 5192.273081768555, 5196.402413722413, 5280.762365693553, 5254.369475662926, 5269.6311258211945, 5269.710165940872, 5270.947290527103, 5272.789088436458, 5186.273921650972, 5253.816116435925, 5253.8949221015555, 5291.0, 5311.707856067915, 5225.242339860718, 5259.132243179871, 5280.1815718563685, 5286.02208591408, 5305.177697456862, 5002.799888004475, 5170.276161337416, 5175.0943584872875, 5186.5850731941355, 5188.22176673502, 5607.859803504904, 5617.9719101404235, 5625.887482250373, 5631.155326700987, 5659.264295641581, 6103.176071230371, 6250.812475625738, 6257.374262573751, 6263.749450021994, 6267.5299352548745, 6169.074638804171, 6207.162033125561, 6215.968920155416, 6235.906461403082, 6240.31356550779, 5785.566082543826, 5853.443922827325, 5868.178455016301, 5884.293884733816, 5894.233749612523, 6233.781817636452, 6241.34465881085, 6249.125122482856, 6258.43674069336, 6264.5301602379095, 6068.0, 6070.423309785563, 6137.171481849982, 6142.3550527194, 6146.385361463817, 6135.508280839725, 6246.593971391845, 6248.687565621701, 6252.531060170505, 6256.061590761331, 6135.07973803933, 6242.1261023456755, 6246.281677607042, 6254.405831446005, 6259.1550140730415, 6116.701002199504, 6166.075088736726, 6223.159873417031, 6274.2784579773, 6276.309605943343, 4917.582005529499, 4938.234573641092, 4941.061198372369, 4942.975285123552, 4945.727984960789, 3783.0, 4325.84859529915, 4340.500842403101, 4435.933460998088, 4436.977815110969, 5745.310562732415, 5760.049591817303, 5767.682777447197, 5767.913481297784, 5810.4770570648, 6196.690165491707, 6223.1287619733275, 6243.188385509855, 6254.34329395416, 6256.5307601930035, 5645.294338207724, 5738.856528586819, 5749.741261643236, 5763.538916886639, 5766.163906233656, 5296.7351632418995, 5318.0, 5318.813841515605, 5331.546818520392, 5369.3556773187465, 6254.655993920287, 6293.937060629427, 6311.053341998737, 6314.55798094129, 6321.399467050623, 5140.845774626767, 6142.447179753844, 6214.0, 6230.875382492415, 6246.843828904132, 6209.534284928739, 6280.214973128359, 6301.558890877594, 6307.463865571478, 6310.368963103653, 5116.590672746246, 6151.96924015395, 6152.969235153795, 6164.722587483484, 6167.982282923447, 6119.99004232014, 6137.376985335611, 6186.381361863778, 6191.380861913773, 6232.594881332699, 6094.08036468511, 6143.634700640197, 6154.261488621215, 6160.13758073861, 6172.814815555361, 6107.53030159963, 6134.724336736039, 6135.569531795875, 6145.525073982301, 6149.139120523041, 5848.298204215522, 5908.586398952032, 5966.254218222723, 6003.769137822133, 6044.304904935989, 6102.328743838086, 6128.525473180255, 6131.842101317736, 6135.355787642234, 6141.6007959482495, 5843.181954526284, 6010.0, 6020.187274717857, 6026.096085587197, 6031.487323577545], "unit": "score", "name": "dojo.html", "value": 5695.465803847042}, {"lowerIsBetter": false, "replicates": [458.0404053507904, 578.8089930322993, 600.2976517474557, 656.7274581048865, 659.9505037122216, 27820.443591128165, 32406.351872962558, 32429.837850810713, 37004.81497592515, 40124.79937600308, 43827.561724382744, 44433.8891527712, 44609.330860037124, 44611.33083003757, 44744.0, 9762.26782991275, 9993.600255989788, 9994.600215991351, 9997.0, 10028.498575071217, 9794.167495762833, 9903.653372131977, 9908.752281192956, 9916.851247231261, 9925.354851934637, 10017.148542373907, 10068.395896246213, 10100.141487973495, 10109.090181883628, 10109.292349535535, 9985.500724963758, 10066.446345450997, 10067.29528932975, 10072.899271007269, 10075.34510256831, 9782.364146330467, 9920.801583968352, 9923.503824808802, 9928.205743540499, 9932.503374831229, 42851.0, 43255.35116973248, 43267.56732432667, 43284.18652787559, 43321.35017974733, 3214.9357012859614, 3227.919302017445, 3309.3050459403553, 3427.417339052367, 3851.9229615407817, 29599.70400295991, 29896.701032989607, 29953.0, 30130.0, 30300.54549181764, 2711.9050833220745, 2757.7518023377993, 2794.748472637452, 2812.395335002984, 2823.774098072149, 478874.0, 480129.0, 481200.5939970313, 482141.0, 482597.0, 72746.63626681833, 73077.6346118266, 73212.63393682998, 73243.63378183075, 73283.26716732871, 77334.0, 80816.59591702004, 82065.58967205125, 82084.17915820885, 82113.58943205245, 18978.52553686169, 19047.42857714271, 19167.904160479386, 19199.0, 19228.807711922982, 14223.359948802328, 14295.78556321656, 14303.499377521737, 14315.069520481135, 14330.211838348783, 23760.0, 23906.402339941294, 24061.75938240595, 24117.75882241155, 24190.87904560466, 8888.266787976412, 9044.683436079706, 9053.818923621491, 9065.546722663972, 9070.773230669154, 1026.7741096958657, 1065.8667666541528, 1075.7955988362187, 1078.687180717583, 1175.8118701007968, 30910.53634195489, 30924.845375772977, 31074.378512430078, 31356.24822867793, 31363.84318078395, 1024.5645600619855, 1130.6947124276398, 1132.3206076354122, 1138.635636596298, 1156.7744289863397, 13624.0, 15688.686226275411, 15830.0, 16074.254715572448, 16152.515424537283, 524881.0, 761504.0, 768520.0, 769262.0, 769991.0, 61303.0, 61469.0, 62242.755144897754, 62284.68857655773, 62341.376586234466, 1411.181514721459, 1447.261896432827, 1535.884808639379, 1571.6483823911426, 1574.3623832347917, 30168.94408695685, 32195.712171513813, 32635.673643264214, 32915.670843291264, 33026.83486582552, 58762.0, 59075.704621476616, 59276.70361648337, 59386.812263755346, 59499.0, 499628.0, 503351.0, 503655.0, 503867.0, 505515.0, 38283.61716382912, 46302.536974629824, 46904.06191876212, 47076.52923470722, 47174.05651886875, 45948.770256148506, 46019.76990115028, 46022.76988615035, 46273.3059004122, 47710.76144619255, 36834.44748328724, 37844.432333514465, 37935.05162370963, 38232.8703198065, 39577.0, 36277.45583816192, 36632.45051324179, 38698.839034829, 39168.0, 39457.80271098626, 38614.80692596632, 39286.80356598199, 39299.803500982314, 39416.2116757669, 39450.0, 34150.31699366048, 34457.0, 34988.0, 35103.47344789881, 35206.47190292199, 22335.553288934454, 25951.091711790752, 26136.8693156533, 26198.73801261963, 26648.733512664625], "unit": "score", "name": "ext.html", "value": 21350.93925797483}, {"lowerIsBetter": false, "replicates": [325.58000179768095, 355.56798489834875, 377.1551724137931, 377.7318104146056, 382.1478103828463, 19702.90148549257, 20452.07965641544, 20735.0, 20884.582308353823, 20907.954602269903, 11936.925676689096, 12300.077494187926, 12309.015278777699, 12314.384280785947, 12321.938390308058, 5254.973725131369, 5441.2654291670715, 5460.863478413052, 6120.724567394478, 6131.3868613138775, 6040.426159514839, 6063.939360606404, 6086.421789929972, 6099.329073801879, 6108.908366374508, 6078.361772013919, 6290.528210384216, 6448.838779030539, 6560.803175904731, 6572.441342485894, 6466.805995820133, 6574.079628851964, 6594.967025164891, 6598.406143447089, 6599.703013364386, 5662.915056274159, 5756.453136951983, 5778.075507918713, 5787.13193021046, 5787.421257874179, 13638.386272617756, 13982.161070335711, 14142.505012324622, 14160.787588186186, 14166.787498187536, 2091.5816836632735, 2147.226998280618, 2233.1737257214772, 2302.067662596651, 2371.063429945162, 9963.302568820185, 10067.395956242648, 10447.68656940293, 12209.511619535208, 15368.615784605363, 1732.3417101501475, 1747.2312182639598, 1755.4996825904684, 1795.3446991848011, 1809.6471188118321, 117052.0, 117979.0, 121115.39442302732, 121469.0, 122202.0, 11506.482208300478, 11527.0, 11534.19260651763, 11567.315237328896, 11718.355490448108, 12199.695007624703, 14528.927355363367, 14663.56009319722, 14675.0, 14694.55916322512, 7513.2862378074, 8739.60671769772, 8938.910610893938, 8977.506237157018, 9021.0, 9037.77405564853, 9066.773330666787, 9070.319726020574, 9163.908360916439, 9170.67902623405, 4169.437125988014, 4483.50681425043, 4485.596296333346, 4517.909641807146, 4545.36364908913, 1557.0190779808647, 1682.5541231573643, 1878.445858471754, 1901.3250296144945, 1904.8571357147991, 916.1434059154711, 973.6300205921705, 992.7418871093568, 1026.3687831983425, 1047.554789214596, 20812.0, 21023.474413139793, 21050.894745526173, 21158.153673852874, 21230.893845530674, 974.541965276319, 988.5353883674661, 1018.0, 1039.194624166262, 1040.6877936618985, 10991.945040274748, 11345.489452974636, 11350.716232094099, 11374.260673056226, 11415.42922853854, 546454.0, 622990.0, 636748.0, 644468.5553144502, 650998.0, 122640.0, 124111.0, 127472.0, 127620.0, 127827.0, 1056.3978532236551, 1063.181350360203, 1091.6561283195767, 1108.5177947592663, 1109.9334039957628, 17966.640667186846, 18744.812551874853, 18828.0, 18855.622887541896, 19074.523136921132, 51386.0, 52275.73862130665, 52986.2052069227, 53145.734271328394, 53757.46242537525, 78118.6094069526, 78249.60875195588, 78944.0, 79638.6018069906, 79895.20104798878, 8230.135835737161, 8233.17668233172, 8329.791755206168, 8382.287505562095, 8605.569721514024, 9405.623775048922, 11522.308661480003, 12862.742745145231, 13507.324633768469, 13948.58154255374, 8857.468551886908, 11422.31466112036, 11664.825027624762, 11840.934315911609, 12047.698807529881, 11444.198906076495, 11561.768764624492, 11754.353510557, 11924.284542927453, 12016.75966480683, 11714.648560543197, 11763.058955283386, 12023.579174729193, 12054.698632534257, 12057.095717821374, 8235.95882020586, 8245.093039765741, 8304.501729896225, 8370.121137280741, 8624.741257762276, 11446.084313254752, 11729.296242225493, 11949.22330048544, 11950.760984780429, 11960.282383057045], "unit": "score", "name": "jquery.html", "value": 9486.183495931098}, {"lowerIsBetter": false, "replicates": [1365.9180449173043, 1640.466848274311, 1671.6322409070008, 2027.8276346510545, 2102.0645812613384, 7303.379212766915, 7808.453408261417, 9034.277257819374, 9035.72892813215, 9039.186473217409, 8670.609822557984, 8974.641014359435, 8981.910180898189, 8982.955085224581, 8995.415298005624, 2261.3442101790542, 2477.009196321477, 2524.7475252474787, 2531.493701259746, 2554.9872250638723, 2551.0051080078783, 2560.2447278052928, 2562.6027965665353, 2562.6540417043648, 2562.8334158279745, 2122.2678176029244, 2454.3005243505604, 2537.5305568469894, 2542.5677634802128, 2545.9490810183784, 2217.9001944912357, 2395.3293077938206, 2519.5842685956795, 2520.596704527267, 2529.3170843872144, 2099.296735593578, 2107.4099252209407, 2460.7047154341594, 2513.258588716333, 2526.886290116931, 9065.320100992452, 9143.405678630868, 9161.358704890661, 9164.991850896396, 9182.357234993553, 5556.86107847303, 5643.6049476536655, 5661.5187709044785, 5672.461116193955, 5750.741216645261, 3603.621619729943, 3659.1035196377056, 3733.4213196954515, 3740.551133863954, 3759.548854137521, 1060.5015642647943, 1069.059227879461, 1079.0, 1082.1667316166586, 1104.469854469859, 12339.5064197432, 12356.62930112098, 12366.0, 12366.44351004207, 12372.876271237263, 4405.361222622766, 4909.2881532177635, 4920.458749537548, 4935.777889994959, 5036.64743467961, 9679.274054445805, 9686.225101991824, 10436.791264174673, 10438.269321147598, 10457.267991240693, 5645.379008309083, 5647.802326918621, 5658.91511627326, 5661.716914154275, 5688.146777983253, 4548.0221752323405, 4674.0651869625535, 4855.5387238212315, 5021.0, 5025.748712564357, 3931.68546516278, 3989.940150897739, 4010.7593544387432, 4029.7985100744845, 4047.817848196838, 1327.2965328375976, 1342.3489607540334, 1345.2466618693563, 1348.6695759538975, 1350.473315406992, 1398.2309729648653, 1405.4237762517319, 1447.3776276201124, 1448.2396741710686, 1450.1226757811583, 8352.707655232038, 8369.83260334802, 8434.493930364199, 8500.277476414574, 8519.0, 519.828456609318, 529.9258103865462, 530.4986787485866, 533.2933862632028, 534.3267482971484, 5276.868078298074, 6278.560500764994, 6342.968285158545, 6355.904661430082, 6359.3640635936035, 10627.309224900357, 10965.83551246732, 10969.0, 10973.3964631946, 10999.61501347465, 9204.0, 10729.302595331279, 10828.022313733396, 10884.183686223407, 10956.835647465294, 8549.0, 8566.18621230982, 8618.439801412887, 8620.827583448421, 8635.179657932485, 8044.477108987897, 8074.273315401642, 8123.593820308843, 8125.146859579895, 8155.714549990722, 9600.087991640783, 9859.802803943738, 9891.653792117242, 9947.701568952943, 9966.252531060054, 10069.144122749649, 10210.489475526343, 10324.07083362501, 10362.378257304586, 10367.377957322586, 6738.460923126237, 6961.930380696128, 7174.569525828467, 7596.240375962359, 7677.9232207677205, 6647.5014373921185, 8346.749597512084, 8398.286145677686, 8430.156984301766, 8721.781955451164, 6386.137871387489, 7240.818979525554, 7381.7416390428225, 7424.480286379901, 7506.0, 7332.743353982798, 7367.742129025459, 7377.963110184414, 7390.076240469942, 7472.813179670552, 7790.415718821225, 7869.606519674108, 7876.763697089096, 7879.724209652634, 7885.763427097197, 7064.964675176591, 7071.080759501232, 7153.928460715326, 7154.105736782903, 7156.354038571262, 7257.637118144177, 7320.341169294789, 7339.082614673166, 7344.339009489172, 7345.889811652936], "unit": "score", "name": "mootools.html", "value": 4929.006650722428}, {"lowerIsBetter": false, "replicates": [322.4051624752333, 331.68489934562166, 340.526667931575, 340.95908490981077, 342.42814499785356, 6689.933100668992, 6725.361090696389, 6728.831779205516, 6786.694598743056, 6789.3889549940495, 5348.866278343044, 6677.298883617211, 6685.532012759097, 6686.765963191289, 6689.498287628423, 4727.858164255061, 4816.277558366256, 4850.320955066293, 4915.5821755150855, 4965.131102057144, 4933.260010998361, 4948.183549714293, 4948.7773050212645, 4954.455009948902, 4966.453690094087, 4086.4483294755273, 4583.739471645291, 4906.141425250585, 4907.975460122712, 4927.778249978742, 4183.3097538906195, 4758.690685105457, 4891.5353041461, 4896.779644915988, 4897.559219670211, 4197.370394440828, 4208.3687446882905, 4209.6000879916355, 4213.936790948138, 4217.0, 6289.7169627366875, 6386.10594516768, 6420.0690899819265, 6447.871042579122, 6453.032045193212, 5886.293644762613, 5887.381824908366, 5891.175235467038, 5893.970530147321, 5896.262967129109, 6784.559003664746, 7080.398166155883, 7082.858342833115, 7092.645367731644, 7093.219745827955, 4614.330922016289, 4621.145088158702, 4637.2116740153915, 4659.464161621389, 4660.883477913046, 6478.222613286436, 7199.6040217788, 7563.584002879839, 7568.356689681384, 7588.089429268523, 4707.7175369477945, 4718.150732868048, 4728.881777955578, 4732.574068333797, 4734.337192793012, 4800.879978000508, 4805.7597120143855, 4809.134355815987, 4809.158397280462, 4812.398450193726, 5577.27495425592, 5742.598018138774, 5742.827715168552, 5743.655380677173, 5753.108268218432, 6511.413972742381, 6673.499487538454, 7158.176809666851, 7176.7846964591145, 7177.246389129171, 1614.0799744145725, 1655.6854197702398, 1658.8589969852455, 1661.6261341198376, 1664.1097013097935, 989.7030890732751, 1017.3234798858676, 1043.3426941027255, 1045.137761346892, 1071.1912506057877, 5171.844844654666, 6630.336966303427, 6662.700178491979, 6774.898376524356, 6820.965895170492, 7472.364848987788, 7473.215312392229, 7478.775636730907, 7484.476086673881, 7491.138519070377, 6768.255491895888, 6788.389044985975, 6794.592324460548, 6806.659667016629, 6807.4894382921475, 3781.4327850822597, 3874.380099184117, 3921.0, 3924.803759811998, 3927.7839718815167, 6269.780557680459, 6705.4970877184405, 7742.4580279381025, 7771.184025677222, 7784.610769461618, 7584.469087163846, 7671.693132274647, 7676.040494938133, 7685.4620176587105, 7785.92214077852, 7010.719571217196, 7759.68961241544, 7761.61191940412, 7776.300132987945, 7782.766517004499, 7168.24733403006, 7401.481896267425, 7412.888806667796, 7413.629318534159, 7423.851522969619, 7287.578922110138, 7319.0, 7333.1200255969625, 7336.266373362621, 7336.633168341455, 7743.728969486041, 7750.341220996278, 7760.3403710685225, 7769.300762931363, 7794.181610930771, 4726.787294571684, 4748.311494833299, 4752.976235118802, 4754.595859351994, 4764.666473346832, 5647.5481961442165, 6419.807405777834, 7145.035420218204, 7373.0, 7384.224656411215, 7151.821204469722, 7185.748498802517, 7193.712251509881, 7196.3163499469565, 7199.568025918462, 6482.092507048923, 6546.639934803441, 7150.928490715234, 7170.2471240519, 7183.820404489929, 6992.0560724303605, 7003.824904377431, 7008.264132266243, 7011.964940175267, 7013.509054366145, 6968.128983877015, 7129.21578626361, 7163.176234733072, 7175.354218120394, 7181.892271616034, 6685.598864068172, 6835.93164068353, 6839.0, 6948.687309071003, 7006.0], "unit": "score", "name": "prototype.html", "value": 5188.879159308808}, {"lowerIsBetter": false, "replicates": [662.2549631664377, 663.9369259920306, 671.9294474080222, 716.9247229040953, 726.4987158860386, 12661.0, 15175.08949463033, 15234.847651523482, 15244.618884527892, 15307.846921530781, 14339.42642294307, 14565.27173641319, 14573.92713036436, 14574.0, 14574.344154513046, 778.105179044101, 787.7479206653844, 941.7221919533737, 961.7835986902926, 988.4365911430488, 975.7755716185246, 978.2711879649636, 981.6515137126324, 982.6855406269997, 983.8917719050899, 1030.8350663893777, 1032.9328593641426, 1033.689893032091, 1033.8087453821067, 1037.4086770540796, 811.0834756724893, 1012.3369193178443, 1031.8813336466328, 1032.4837581209395, 1034.818906691326, 761.4213197969527, 762.2263402646319, 763.3435245688703, 763.8968739220189, 766.0309708219107, 15547.689046219126, 15604.29780659873, 15621.92189039059, 15639.843601564065, 15665.530034098996, 12982.545610903573, 12998.675033124153, 13160.14459060158, 13216.273104979222, 13583.539910758553, 10076.907710747133, 10115.797684046278, 10154.9492252539, 10500.474976251233, 10558.155347572176, 3524.682778549917, 3539.50446937429, 3570.4465807799575, 3620.8913732588067, 3766.9623303766884, 83510.58244708799, 85416.14583854144, 85645.57177214137, 85663.0, 86426.0, 9682.79470943162, 9803.264755143393, 9881.110700037032, 10037.046480584333, 10102.797944041078, 23665.408364790674, 23741.931613077453, 23749.762502375102, 23773.0, 23784.762152378255, 7354.558726476428, 7417.0, 7488.588127653032, 7655.0813902332075, 7737.92262077372, 4044.4742183515955, 4132.111596006813, 4208.074223670787, 4249.68127390447, 4410.095930334273, 3718.7025037996896, 3749.49381833449, 3758.9060273493383, 3762.811859407019, 3763.2285381496727, 624.8687775567091, 637.7990932856228, 640.5996252342286, 653.6143675231637, 653.8888388973886, 557.9191017302469, 610.081826850587, 610.8259146143328, 612.7395856760859, 616.3559080760616, 7572.7728168155045, 8109.716159934492, 8250.339972802161, 8294.40242510058, 8516.70191543293, 582.7377680043998, 598.5720210049835, 602.1900543768625, 609.5641616244407, 617.9165812615329, 3662.406853018945, 3833.0225792422752, 3860.8069596520063, 3886.436466712311, 3893.6885049196, 99672.5016374928, 101532.0, 101604.49197754111, 101786.0, 101957.49021254995, 61055.99999999911, 85605.0, 86323.0, 87065.0, 88895.55552222327, 54325.72837135868, 71223.0, 74131.0, 75959.62020189864, 76889.84665230026, 6340.397662222082, 7766.417518686008, 7808.9609551954145, 7812.023497062867, 7832.334251588451, 45018.549814501435, 50982.49017509777, 52117.47882521278, 53045.4695453056, 53844.73077634744, 63207.0, 69980.0, 72813.63593182, 73948.63025684837, 74726.62636686781, 9930.413385336467, 10140.0, 10182.643607473703, 10210.591576337161, 10483.318584291997, 10192.592296308065, 10408.47957602132, 10515.369077855354, 10526.0, 10855.67432977012, 10030.598776048877, 10045.196384289386, 10181.440020798631, 10298.330608510423, 10403.115735162293, 8737.21365077146, 10030.247731420026, 10056.396616203052, 10320.380777153396, 10681.305715128492, 9870.457124857914, 9967.202623790225, 9987.60049598008, 10120.493975301353, 10170.644027459004, 8545.615447304763, 8628.654853805778, 8760.38866861702, 8793.648254069765, 8893.110688931056, 8788.516631585324, 8821.955890220508, 8839.381243313164, 8865.468071915706, 8945.15021072997], "unit": "score", "name": "yui.html", "value": 6922.876986772152}], "name": "dromaeo_css", "value": 7674.1882421900755}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 109.0, 108.0, 109.0, 110.0, 119.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 120.0, 153.0, 147.0, 116.0, 168.0, 141.0, 157.0, 146.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [182.0, 186.0, 185.0, 188.0, 184.0, 185.0, 183.0, 186.0, 184.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [72.0, 77.0, 73.0, 118.0, 56.0, 59.0, 58.0, 59.0, 124.0, 60.0], "unit": "score", "name": "audio-fft", "value": 75.6}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 130.0, 86.0, 111.0, 121.0, 134.0, 77.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 91.0, 85.0, 88.0, 84.0, 88.0, 85.0, 89.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 94.0, 95.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 87.0, 85.0, 84.0, 87.0, 86.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 70.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 76.0, 75.0, 69.0, 66.0, 67.0, 72.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 78.0, 78.0, 67.0, 81.0, 70.0, 88.0, 74.0, 81.0, 105.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [119.0, 129.0, 117.0, 142.0, 113.0, 105.0, 104.0, 122.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [133.0, 122.0, 133.0, 135.0, 133.0, 125.0, 162.0, 165.0, 163.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 66.0, 67.0, 65.0, 67.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1415.8999999999999}]} 01:49:03 INFO - Return code: 0 01:49:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:49:03 INFO - # TBPL SUCCESS # 01:49:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:03 INFO - 2016-04-14 01:49:03.498 screenresolution[1960:17709] starting screenresolution argv=screenresolution get 01:49:03 INFO - 2016-04-14 01:49:03.501 screenresolution[1960:17709] Display 0: 1600x1200x32@60 01:49:03 INFO - 2016-04-14 01:49:03.507 screenresolution[1961:17712] starting screenresolution argv=screenresolution list 01:49:03 INFO - Available Modes on Display 0 01:49:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:03 INFO - Intel Iris: 01:49:03 INFO - Chipset Model: Intel Iris 01:49:03 INFO - Type: GPU 01:49:03 INFO - Bus: Built-In 01:49:03 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:03 INFO - Vendor: Intel (0x8086) 01:49:03 INFO - Device ID: 0x0a2e 01:49:03 INFO - Revision ID: 0x0009 01:49:03 INFO - Displays: 01:49:03 INFO - Display: 01:49:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:03 INFO - Display Serial Number: 1600x1200 60 01:49:03 INFO - Main Display: Yes 01:49:03 INFO - Mirror: Off 01:49:03 INFO - Online: Yes 01:49:03 INFO - Rotation: Supported 01:49:03 INFO - Return code: 0 01:49:03 INFO - Running post-action listener: _resource_record_post_action 01:49:03 INFO - Running post-run listener: _resource_record_post_run 01:49:04 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 823296; Write bytes: 663494144; Read time: 10; Write time: 2439 01:49:04 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 353933824; Write bytes: 353673728; Read time: 27946; Write time: 648 01:49:04 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 823296; Write bytes: 299482112; Read time: 10; Write time: 1757 01:49:04 INFO - Running post-run listener: _upload_blobber_files 01:49:04 INFO - Blob upload gear active. 01:49:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:49:04 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 01:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:49:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:49:05 INFO - (blobuploader) - INFO - Done attempting. 01:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:49:06 INFO - (blobuploader) - INFO - Done attempting. 01:49:06 INFO - (blobuploader) - INFO - Iteration through files over. 01:49:06 INFO - Return code: 0 01:49:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:49:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:49:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c80c13973c02245d3f841543c0e6e6b1ad6ec5afc81e3bf32814b0a0c039982d37b37ec35cc20810dd8177ce95ae290b1d6092f538b171c9868102404b4e2205", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8f91ebbd6071636e558ca9e41ae7bfffc536a7aa1bd59516ccca9822b30c7fd8925b22cef622ac40aecc804d48c8a2a284ea536dad320bdc9b06eb115de43f2"} 01:49:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:49:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:49:06 INFO - Contents: 01:49:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c80c13973c02245d3f841543c0e6e6b1ad6ec5afc81e3bf32814b0a0c039982d37b37ec35cc20810dd8177ce95ae290b1d6092f538b171c9868102404b4e2205", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8f91ebbd6071636e558ca9e41ae7bfffc536a7aa1bd59516ccca9822b30c7fd8925b22cef622ac40aecc804d48c8a2a284ea536dad320bdc9b06eb115de43f2"} 01:49:06 INFO - Running post-run listener: copy_logs_to_upload_dir 01:49:06 INFO - Copying logs to upload dir... 01:49:06 INFO - mkdir: /builds/slave/test/build/upload/logs 01:49:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.682247 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-14 01:49:06.870269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 01:49:06.874125) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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/Mozilla-Aurora/sha512/c80c13973c02245d3f841543c0e6e6b1ad6ec5afc81e3bf32814b0a0c039982d37b37ec35cc20810dd8177ce95ae290b1d6092f538b171c9868102404b4e2205", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8f91ebbd6071636e558ca9e41ae7bfffc536a7aa1bd59516ccca9822b30c7fd8925b22cef622ac40aecc804d48c8a2a284ea536dad320bdc9b06eb115de43f2"} build_url:https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010918 build_url: 'https://queue.taskcluster.net/v1/task/SW6x7cLASsWwqNRsZQ0Y2Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c80c13973c02245d3f841543c0e6e6b1ad6ec5afc81e3bf32814b0a0c039982d37b37ec35cc20810dd8177ce95ae290b1d6092f538b171c9868102404b4e2205", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8f91ebbd6071636e558ca9e41ae7bfffc536a7aa1bd59516ccca9822b30c7fd8925b22cef622ac40aecc804d48c8a2a284ea536dad320bdc9b06eb115de43f2"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 01:49:06.962420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:49:06.965725) ========= 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.QQHSF1aJZb/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.QOr8jeejzv/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.004547 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 01:49:06.994094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 01:49:06.994391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 01:49:06.994743) ========= ========= Total master_lag: 0.30 =========