builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0110 starttime: 1458230109.75 results: success (0) buildid: 20160317072613 builduid: 4cf14b67a15e463e95beab8b7909bc57 revision: 112cb0b69503ef77205124328c00fcc44a2297f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:55:09.754167) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:55:09.754682) ========= ========= Started set props: basedir (results: 0, elapsed: 14 secs) (at 2016-03-17 08:55:09.754997) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005284 basedir: '/builds/slave/test' ========= master_lag: 14.80 ========= ========= Finished set props: basedir (results: 0, elapsed: 14 secs) (at 2016-03-17 08:55:24.556858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 mins, 12 secs) (at 2016-03-17 08:55:24.557170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 mins, 12 secs) (at 2016-03-17 08:56:37.014830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2016-03-17 08:56:37.015138) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005432 ========= master_lag: 11.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2016-03-17 08:56:48.518811) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 08:56:48.519120) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 08:56:48.519552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-17 08:56:48.519840) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-17 08:56:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 130M=0s 2016-03-17 08:56:50 (130 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.651008 ========= master_lag: 9.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-17 08:56:58.705295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-03-17 08:56:58.705610) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.020341 ========= master_lag: 4.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-03-17 08:57:02.823809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 22 secs) (at 2016-03-17 08:57:02.824209) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 112cb0b69503ef77205124328c00fcc44a2297f3 --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 112cb0b69503ef77205124328c00fcc44a2297f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-17 08:57:04,018 truncating revision to first 12 chars 2016-03-17 08:57:04,018 Setting DEBUG logging. 2016-03-17 08:57:04,018 attempt 1/10 2016-03-17 08:57:04,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/112cb0b69503?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 08:57:04,706 unpacking tar archive at: mozilla-aurora-112cb0b69503/testing/mozharness/ program finished with exit code 0 elapsedTime=0.939989 ========= master_lag: 21.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 22 secs) (at 2016-03-17 08:57:25.611060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-03-17 08:57:25.611390) ========= echo 112cb0b69503ef77205124328c00fcc44a2297f3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'112cb0b69503ef77205124328c00fcc44a2297f3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 112cb0b69503ef77205124328c00fcc44a2297f3 program finished with exit code 0 elapsedTime=0.005343 script_repo_revision: '112cb0b69503ef77205124328c00fcc44a2297f3' ========= master_lag: 9.57 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-03-17 08:57:35.188437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 46 secs) (at 2016-03-17 08:57:35.188738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 46 secs) (at 2016-03-17 08:58:21.871695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-17 08:58:21.872013) ========= /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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:58:22 INFO - MultiFileLogger online at 20160317 08:58:22 in /builds/slave/test 08:58:22 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 08:58:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:22 INFO - {'append_to_log': False, 08:58:22 INFO - 'base_work_dir': '/builds/slave/test', 08:58:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:58:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:22 INFO - 'branch': 'Mozilla-Aurora', 08:58:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:22 INFO - 'config_files': ('talos/mac_config.py',), 08:58:22 INFO - 'default_actions': ('clobber', 08:58:22 INFO - 'read-buildbot-config', 08:58:22 INFO - 'download-and-extract', 08:58:22 INFO - 'populate-webroot', 08:58:22 INFO - 'create-virtualenv', 08:58:22 INFO - 'install', 08:58:22 INFO - 'run-tests'), 08:58:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:22 INFO - 'download_minidump_stackwalk': True, 08:58:22 INFO - 'download_symbols': 'ondemand', 08:58:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:22 INFO - 'installer_path': 'installer.exe', 08:58:22 INFO - 'log_level': 'info', 08:58:22 INFO - 'log_name': 'talos', 08:58:22 INFO - 'log_to_console': True, 08:58:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:58:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:58:22 INFO - 'opt_config_files': (), 08:58:22 INFO - 'pip_index': False, 08:58:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:22 INFO - 'cmd': ('bash', 08:58:22 INFO - '-c', 08:58:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:22 INFO - 'enabled': True, 08:58:22 INFO - 'halt_on_failure': False, 08:58:22 INFO - 'name': 'check_screen_resolution'},), 08:58:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:22 INFO - 'cmd': ('bash', 08:58:22 INFO - '-c', 08:58:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:22 INFO - 'enabled': True, 08:58:22 INFO - 'halt_on_failure': False, 08:58:22 INFO - 'name': 'check_screen_resolution'},), 08:58:22 INFO - 'run_cmd_checks_enabled': True, 08:58:22 INFO - 'sps_profile': False, 08:58:22 INFO - 'sps_profile_interval': 0, 08:58:22 INFO - 'suite': 'dromaeojs', 08:58:22 INFO - 'system_bits': '32', 08:58:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:22 INFO - 'title': 't-yosemite-r7-0110', 08:58:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:22 INFO - 'use_talos_json': True, 08:58:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:22 INFO - 'work_dir': 'build'} 08:58:22 INFO - ##### 08:58:22 INFO - ##### Running clobber step. 08:58:22 INFO - ##### 08:58:22 INFO - Running pre-action listener: _resource_record_pre_action 08:58:22 INFO - Running main action method: clobber 08:58:22 INFO - rmtree: /builds/slave/test/build 08:58:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:24 INFO - Running post-action listener: _resource_record_post_action 08:58:24 INFO - ##### 08:58:24 INFO - ##### Running read-buildbot-config step. 08:58:24 INFO - ##### 08:58:24 INFO - Running pre-action listener: _resource_record_pre_action 08:58:24 INFO - Running main action method: read_buildbot_config 08:58:24 INFO - Using buildbot properties: 08:58:24 INFO - { 08:58:24 INFO - "project": "", 08:58:24 INFO - "product": "firefox", 08:58:24 INFO - "script_repo_revision": "production", 08:58:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:58:24 INFO - "repository": "", 08:58:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:58:24 INFO - "buildid": "20160317072613", 08:58:24 INFO - "pgo_build": "False", 08:58:24 INFO - "basedir": "/builds/slave/test", 08:58:24 INFO - "buildnumber": 226, 08:58:24 INFO - "slavename": "t-yosemite-r7-0110", 08:58:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:58:24 INFO - "platform": "yosemite_r7", 08:58:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:58:24 INFO - "branch": "mozilla-aurora", 08:58:24 INFO - "repo_path": "releases/mozilla-aurora", 08:58:24 INFO - "revision": "112cb0b69503ef77205124328c00fcc44a2297f3", 08:58:24 INFO - "stage_platform": "macosx64", 08:58:24 INFO - "builduid": "4cf14b67a15e463e95beab8b7909bc57", 08:58:24 INFO - "slavebuilddir": "test" 08:58:24 INFO - } 08:58:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 08:58:24 INFO - Running post-action listener: _resource_record_post_action 08:58:24 INFO - ##### 08:58:24 INFO - ##### Running download-and-extract step. 08:58:24 INFO - ##### 08:58:24 INFO - Running pre-action listener: _resource_record_pre_action 08:58:24 INFO - Running main action method: download_and_extract 08:58:24 INFO - mkdir: /builds/slave/test/build/tests 08:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:24 INFO - https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:58:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:58:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:58:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:27 INFO - Downloaded 1277 bytes. 08:58:27 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:58:27 INFO - Using the following test package requirements: 08:58:27 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:58:27 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 08:58:27 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 08:58:27 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'jsshell-mac.zip'], 08:58:27 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 08:58:27 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:58:27 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 08:58:27 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 08:58:27 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 08:58:27 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:58:27 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:58:27 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 08:58:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:27 INFO - https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:30 INFO - Downloaded 17867659 bytes. 08:58:30 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'] 08:58:30 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 08:58:34 INFO - Return code: 0 08:58:34 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 08:58:34 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')]} 08:58:34 INFO - https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:36 INFO - Downloaded 17867659 bytes. 08:58:36 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'] 08:58:36 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 08:58:40 INFO - Return code: 0 08:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:40 INFO - https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:41 INFO - Downloaded 10845161 bytes. 08:58:41 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'] 08:58:41 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 08:58:41 INFO - Return code: 0 08:58: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')]} 08:58:41 INFO - https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 08:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z_mP95A6TP6orScXQfLccw/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 08:58:47 INFO - Downloaded 114971918 bytes. 08:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:58:47 INFO - mkdir: /builds/slave/test/properties 08:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:58:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:58:47 INFO - Contents: 08:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:58:47 INFO - Running post-action listener: _resource_record_post_action 08:58:47 INFO - Running post-action listener: set_extra_try_arguments 08:58:47 INFO - ##### 08:58:47 INFO - ##### Running populate-webroot step. 08:58:47 INFO - ##### 08:58:47 INFO - Running pre-action listener: _resource_record_pre_action 08:58:47 INFO - Running main action method: populate_webroot 08:58:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:47 INFO - '--tppagecycles', 08:58:47 INFO - '7'], 08:58:47 INFO - 'tests': ['tsvgm']}}, 08:58:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:58:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:58:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:58:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'tests': ['damp', 'tps']}, 08:58:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['damp', 'tps']}, 08:58:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:58:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:47 INFO - 'other': {'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'other_l64': {'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'other_nol64': {'tests': ['a11yr', 08:58:47 INFO - 'ts_paint', 08:58:47 INFO - 'tpaint', 08:58:47 INFO - 'sessionrestore', 08:58:47 INFO - 'sessionrestore_no_auto_restore', 08:58:47 INFO - 'tabpaint']}, 08:58:47 INFO - 'svgr': {'tests': ['tsvgx', 08:58:47 INFO - 'tsvgr_opacity', 08:58:47 INFO - 'tart', 08:58:47 INFO - 'tscrollx', 08:58:47 INFO - 'cart']}, 08:58:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['tsvgx', 08:58:47 INFO - 'tsvgr_opacity', 08:58:47 INFO - 'tart', 08:58:47 INFO - 'tscrollx', 08:58:47 INFO - 'cart']}, 08:58:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'tests': ['tp5o']}, 08:58:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'talos_options': ['--e10s'], 08:58:47 INFO - 'tests': ['tp5o']}, 08:58:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'talos_options': ['--xperf_path', 08:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:47 INFO - 'tests': ['tp5n']}, 08:58:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:47 INFO - 'talos_options': ['--e10s', 08:58:47 INFO - '--xperf_path', 08:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:47 INFO - 'tests': ['tp5n']}}, 08:58:47 INFO - 'talos.zip': {'path': '', 08:58:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:47 INFO - Running post-action listener: _resource_record_post_action 08:58:47 INFO - ##### 08:58:47 INFO - ##### Running create-virtualenv step. 08:58:47 INFO - ##### 08:58:47 INFO - Running pre-action listener: _resource_record_pre_action 08:58:47 INFO - Running main action method: create_virtualenv 08:58:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:58:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:58:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:58:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:48 INFO - Using real prefix '/tools/python27' 08:58:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:58:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:51 INFO - Installing pip.................done. 08:58:51 INFO - Return code: 0 08:58:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:58: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', 'pip>=1.5'] in /builds/slave/test/build 08:58: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 pip>=1.5 08:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:51 INFO - 'HOME': '/Users/cltbld', 08:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:51 INFO - 'LOGNAME': 'cltbld', 08:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:51 INFO - 'MOZ_NO_REMOTE': '1', 08:58:51 INFO - 'NO_EM_RESTART': '1', 08:58:51 INFO - 'PAGER': '/bin/cat', 08:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:51 INFO - 'PWD': '/builds/slave/test', 08:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:51 INFO - 'SHELL': '/bin/bash', 08:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:58:51 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:51 INFO - 'USER': 'cltbld', 08:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:51 INFO - 'XPC_FLAGS': '0x0', 08:58:51 INFO - 'XPC_SERVICE_NAME': '0', 08:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:51 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 08:58:51 INFO - Cleaning up... 08:58:51 INFO - Return code: 0 08:58:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', '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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:58: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:58: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 psutil>=0.7.1 08:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:51 INFO - 'HOME': '/Users/cltbld', 08:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:51 INFO - 'LOGNAME': 'cltbld', 08:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:51 INFO - 'MOZ_NO_REMOTE': '1', 08:58:51 INFO - 'NO_EM_RESTART': '1', 08:58:51 INFO - 'PAGER': '/bin/cat', 08:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:51 INFO - 'PWD': '/builds/slave/test', 08:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:51 INFO - 'SHELL': '/bin/bash', 08:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:58:51 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:51 INFO - 'USER': 'cltbld', 08:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:51 INFO - 'XPC_FLAGS': '0x0', 08:58:51 INFO - 'XPC_SERVICE_NAME': '0', 08:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:52 INFO - Downloading/unpacking psutil>=0.7.1 08:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:55 INFO - Installing collected packages: psutil 08:58:55 INFO - Running setup.py install for psutil 08:58:55 INFO - building 'psutil._psutil_osx' extension 08:58:55 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 08:58:55 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 08:58:55 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 08:58:55 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 08:58:55 INFO - building 'psutil._psutil_posix' extension 08:58:55 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 08:58:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:58:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:58:55 INFO - ^ 08:58:55 INFO - 1 warning generated. 08:58:55 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 08:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:55 INFO - Successfully installed psutil 08:58:55 INFO - Cleaning up... 08:58:55 INFO - Return code: 0 08:58:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:55 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:58:55 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 08:58:55 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 08:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:55 INFO - 'HOME': '/Users/cltbld', 08:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:55 INFO - 'LOGNAME': 'cltbld', 08:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:55 INFO - 'MOZ_NO_REMOTE': '1', 08:58:55 INFO - 'NO_EM_RESTART': '1', 08:58:55 INFO - 'PAGER': '/bin/cat', 08:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:55 INFO - 'PWD': '/builds/slave/test', 08:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:55 INFO - 'SHELL': '/bin/bash', 08:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:58:55 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:55 INFO - 'USER': 'cltbld', 08:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:55 INFO - 'XPC_FLAGS': '0x0', 08:58:55 INFO - 'XPC_SERVICE_NAME': '0', 08:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:58:56 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 08:58:56 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 08:58:56 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 08:58:56 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 08:58:56 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 08:58:56 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 08:58:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:58:58 INFO - Installing collected packages: mozsystemmonitor 08:58:58 INFO - Running setup.py install for mozsystemmonitor 08:58:58 INFO - Successfully installed mozsystemmonitor 08:58:58 INFO - Cleaning up... 08:58:58 INFO - Return code: 0 08:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:58 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:58:58 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 08:58:58 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 08:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:58 INFO - 'HOME': '/Users/cltbld', 08:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:58 INFO - 'LOGNAME': 'cltbld', 08:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:58 INFO - 'MOZ_NO_REMOTE': '1', 08:58:58 INFO - 'NO_EM_RESTART': '1', 08:58:58 INFO - 'PAGER': '/bin/cat', 08:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:58 INFO - 'PWD': '/builds/slave/test', 08:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:58 INFO - 'SHELL': '/bin/bash', 08:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:58:58 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:58 INFO - 'USER': 'cltbld', 08:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:58 INFO - 'XPC_FLAGS': '0x0', 08:58:58 INFO - 'XPC_SERVICE_NAME': '0', 08:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:58:59 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 08:58:59 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 08:58:59 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 08:58:59 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 08:58:59 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 08:58:59 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 08:59:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:01 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 08:59:01 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 08:59:01 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 08:59:01 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 08:59:01 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 08:59:01 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 08:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:02 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 08:59:02 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 08:59:02 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 08:59:02 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 08:59:02 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 08:59:02 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 08:59:02 INFO - Downloading docopt-0.6.1.tar.gz 08:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:02 INFO - Running setup.py install for blobuploader 08:59:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:02 INFO - Running setup.py install for requests 08:59:03 INFO - Running setup.py install for docopt 08:59:03 INFO - Successfully installed blobuploader requests docopt 08:59:03 INFO - Cleaning up... 08:59:03 INFO - Return code: 0 08:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:03 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')]} 08:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:03 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')]} 08:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:03 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:59:03 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 08:59:03 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 08:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:03 INFO - 'HOME': '/Users/cltbld', 08:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:03 INFO - 'LOGNAME': 'cltbld', 08:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:03 INFO - 'MOZ_NO_REMOTE': '1', 08:59:03 INFO - 'NO_EM_RESTART': '1', 08:59:03 INFO - 'PAGER': '/bin/cat', 08:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:03 INFO - 'PWD': '/builds/slave/test', 08:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:03 INFO - 'SHELL': '/bin/bash', 08:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:03 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:03 INFO - 'USER': 'cltbld', 08:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:03 INFO - 'XPC_FLAGS': '0x0', 08:59:03 INFO - 'XPC_SERVICE_NAME': '0', 08:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:03 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-41CrQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-509cme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-JSCqh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-2tP31p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-pgYTqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-bBsBxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-fMlyrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-mIeWwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-IbuBoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-sFjDNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:04 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ZyMUrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-l1gDjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-XGoOsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-REYSbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-tuSLjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-DUsPvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:05 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-S4KbDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:05 INFO - Running setup.py install for manifestparser 08:59:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:05 INFO - Running setup.py install for mozcrash 08:59:05 INFO - Running setup.py install for mozdebug 08:59:06 INFO - Running setup.py install for mozdevice 08:59:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Running setup.py install for mozfile 08:59:06 INFO - Running setup.py install for mozhttpd 08:59:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Running setup.py install for mozinfo 08:59:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Running setup.py install for mozInstall 08:59:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:06 INFO - Running setup.py install for mozleak 08:59:06 INFO - Running setup.py install for mozlog 08:59:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Running setup.py install for moznetwork 08:59:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Running setup.py install for mozprocess 08:59:07 INFO - Running setup.py install for mozprofile 08:59:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Running setup.py install for mozrunner 08:59:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:07 INFO - Running setup.py install for mozscreenshot 08:59:07 INFO - Running setup.py install for moztest 08:59:08 INFO - Running setup.py install for mozversion 08:59:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:08 INFO - Cleaning up... 08:59:08 INFO - Return code: 0 08:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:59:08 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 08:59:08 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 08:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:08 INFO - 'HOME': '/Users/cltbld', 08:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:08 INFO - 'LOGNAME': 'cltbld', 08:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:08 INFO - 'MOZ_NO_REMOTE': '1', 08:59:08 INFO - 'NO_EM_RESTART': '1', 08:59:08 INFO - 'PAGER': '/bin/cat', 08:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:08 INFO - 'PWD': '/builds/slave/test', 08:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:08 INFO - 'SHELL': '/bin/bash', 08:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:08 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:08 INFO - 'USER': 'cltbld', 08:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:08 INFO - 'XPC_FLAGS': '0x0', 08:59:08 INFO - 'XPC_SERVICE_NAME': '0', 08:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:08 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-hk0KZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:08 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)) 08:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:08 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-De3PoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:08 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)) 08:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:08 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-vB9bi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:08 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)) 08:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:08 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-jR3h1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:08 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)) 08:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:08 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-snDbWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-pTZNQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-muzIw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-i1QYnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-66o5J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-wFsEjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-8KzHrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-kFS89N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xCUrVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:09 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)) 08:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:09 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-k8Omrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:10 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)) 08:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:10 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-IUNVlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:10 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)) 08:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:10 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-AkdU7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:10 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)) 08:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:10 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-WLvQ7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:10 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)) 08:59:10 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)) 08:59:10 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)) 08:59:10 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)) 08:59:10 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)) 08:59:10 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)) 08:59:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:12 INFO - Downloading blessings-1.6.tar.gz 08:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:12 INFO - Installing collected packages: blessings 08:59:12 INFO - Running setup.py install for blessings 08:59:12 INFO - Successfully installed blessings 08:59:12 INFO - Cleaning up... 08:59:13 INFO - Return code: 0 08:59:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:13 INFO - Reading from file tmpfile_stdout 08:59:13 INFO - Current package versions: 08:59:13 INFO - blessings == 1.6 08:59:13 INFO - blobuploader == 1.2.4 08:59:13 INFO - docopt == 0.6.1 08:59:13 INFO - manifestparser == 1.1 08:59:13 INFO - mozInstall == 1.12 08:59:13 INFO - mozcrash == 0.17 08:59:13 INFO - mozdebug == 0.1 08:59:13 INFO - mozdevice == 0.48 08:59:13 INFO - mozfile == 1.2 08:59:13 INFO - mozhttpd == 0.7 08:59:13 INFO - mozinfo == 0.9 08:59:13 INFO - mozleak == 0.1 08:59:13 INFO - mozlog == 3.1 08:59:13 INFO - moznetwork == 0.27 08:59:13 INFO - mozprocess == 0.22 08:59:13 INFO - mozprofile == 0.28 08:59:13 INFO - mozrunner == 6.11 08:59:13 INFO - mozscreenshot == 0.1 08:59:13 INFO - mozsystemmonitor == 0.0 08:59:13 INFO - moztest == 0.7 08:59:13 INFO - mozversion == 1.4 08:59:13 INFO - psutil == 3.1.1 08:59:13 INFO - requests == 1.2.3 08:59:13 INFO - wsgiref == 0.1.2 08:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:13 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')]} 08:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:13 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')]} 08:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:13 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:59:13 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 08:59:13 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 08:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:13 INFO - 'HOME': '/Users/cltbld', 08:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:13 INFO - 'LOGNAME': 'cltbld', 08:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:13 INFO - 'MOZ_NO_REMOTE': '1', 08:59:13 INFO - 'NO_EM_RESTART': '1', 08:59:13 INFO - 'PAGER': '/bin/cat', 08:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:13 INFO - 'PWD': '/builds/slave/test', 08:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:13 INFO - 'SHELL': '/bin/bash', 08:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:13 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:13 INFO - 'USER': 'cltbld', 08:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:13 INFO - 'XPC_FLAGS': '0x0', 08:59:13 INFO - 'XPC_SERVICE_NAME': '0', 08:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 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)) 08:59:13 INFO - Cleaning up... 08:59:13 INFO - Return code: 0 08:59:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:13 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')]} 08:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:13 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')]} 08:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:13 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 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:59:13 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 08:59:13 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 08:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:13 INFO - 'HOME': '/Users/cltbld', 08:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:13 INFO - 'LOGNAME': 'cltbld', 08:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:13 INFO - 'MOZ_NO_REMOTE': '1', 08:59:13 INFO - 'NO_EM_RESTART': '1', 08:59:13 INFO - 'PAGER': '/bin/cat', 08:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:13 INFO - 'PWD': '/builds/slave/test', 08:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:13 INFO - 'SHELL': '/bin/bash', 08:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:13 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:13 INFO - 'USER': 'cltbld', 08:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:13 INFO - 'XPC_FLAGS': '0x0', 08:59:13 INFO - 'XPC_SERVICE_NAME': '0', 08:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:13 INFO - Downloading/unpacking jsonschema 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:16 INFO - Downloading/unpacking functools32 (from jsonschema) 08:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:16 INFO - warning: no files found matching '*.txt' 08:59:16 INFO - no previously-included directories found matching 'build' 08:59:16 INFO - no previously-included directories found matching 'dist' 08:59:16 INFO - no previously-included directories found matching '.git*' 08:59:16 INFO - Installing collected packages: jsonschema, functools32 08:59:16 INFO - Running setup.py install for functools32 08:59:16 INFO - warning: no files found matching '*.txt' 08:59:16 INFO - no previously-included directories found matching 'build' 08:59:16 INFO - no previously-included directories found matching 'dist' 08:59:16 INFO - no previously-included directories found matching '.git*' 08:59:16 INFO - Successfully installed jsonschema functools32 08:59:16 INFO - Cleaning up... 08:59:17 INFO - Return code: 0 08:59:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108596a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fd848ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, '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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 08:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:17 INFO - 'HOME': '/Users/cltbld', 08:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:17 INFO - 'LOGNAME': 'cltbld', 08:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:17 INFO - 'MOZ_NO_REMOTE': '1', 08:59:17 INFO - 'NO_EM_RESTART': '1', 08:59:17 INFO - 'PAGER': '/bin/cat', 08:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:17 INFO - 'PWD': '/builds/slave/test', 08:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:17 INFO - 'SHELL': '/bin/bash', 08:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:17 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:17 INFO - 'USER': 'cltbld', 08:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:17 INFO - 'XPC_FLAGS': '0x0', 08:59:17 INFO - 'XPC_SERVICE_NAME': '0', 08:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:17 INFO - Downloading/unpacking flake8 08:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:59:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:59:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:20 INFO - no previously-included directories found matching 'docs/_build' 08:59:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:59:20 INFO - Running setup.py install for pep8 08:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:21 INFO - no previously-included directories found matching 'docs/_build' 08:59:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:59:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:59:21 INFO - Cleaning up... 08:59:21 INFO - Return code: 0 08:59:21 INFO - Running post-action listener: _resource_record_post_action 08:59:21 INFO - Running post-action listener: _start_resource_monitoring 08:59:21 INFO - Starting resource monitoring. 08:59:21 INFO - ##### 08:59:21 INFO - ##### Running install step. 08:59:21 INFO - ##### 08:59:21 INFO - Running pre-action listener: _resource_record_pre_action 08:59:21 INFO - Running main action method: install 08:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:21 INFO - Reading from file tmpfile_stdout 08:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:21 INFO - Reading from file tmpfile_stdout 08:59:21 INFO - Output received: 08:59:21 INFO - Usage: mozinstall [options] installer 08:59:21 INFO - Options: 08:59:21 INFO - -h, --help show this help message and exit 08:59:21 INFO - -d DEST, --destination=DEST 08:59:21 INFO - Directory to install application into. [default: 08:59:21 INFO - "/builds/slave/test"] 08:59:21 INFO - --app=APP Application being installed. [default: firefox] 08:59:21 INFO - mkdir: /builds/slave/test/build/application 08:59:21 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'] 08:59:21 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 08:59:53 INFO - Reading from file tmpfile_stdout 08:59:53 INFO - Output received: 08:59:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:59:53 INFO - Running post-action listener: _resource_record_post_action 08:59:53 INFO - ##### 08:59:53 INFO - ##### Running run-tests step. 08:59:53 INFO - ##### 08:59:53 INFO - Running pre-action listener: _resource_record_pre_action 08:59:53 INFO - Running main action method: run_tests 08:59:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:53 INFO - 2016-03-17 08:59:53.357 screenresolution[1992:11820] starting screenresolution argv=screenresolution get 08:59:53 INFO - 2016-03-17 08:59:53.359 screenresolution[1992:11820] Display 0: 1600x1200x32@60 08:59:53 INFO - 2016-03-17 08:59:53.365 screenresolution[1993:11822] starting screenresolution argv=screenresolution list 08:59:53 INFO - Available Modes on Display 0 08:59:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:53 INFO - Intel Iris: 08:59:53 INFO - Chipset Model: Intel Iris 08:59:53 INFO - Type: GPU 08:59:53 INFO - Bus: Built-In 08:59:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:53 INFO - Vendor: Intel (0x8086) 08:59:53 INFO - Device ID: 0x0a2e 08:59:53 INFO - Revision ID: 0x0009 08:59:53 INFO - Displays: 08:59:53 INFO - Display: 08:59:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:53 INFO - Display Serial Number: 1600x1200 60 08:59:53 INFO - Main Display: Yes 08:59:53 INFO - Mirror: Off 08:59:53 INFO - Online: Yes 08:59:53 INFO - Rotation: Supported 08:59:53 INFO - Return code: 0 08:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:53 INFO - Python 2.7.3 08:59:53 INFO - Return code: 0 08:59:53 INFO - grabbing minidump binary from tooltool 08:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:53 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 0x10843ad30>, '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 0x10829edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108431b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:53 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 08:59:53 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 08:59:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:53 INFO - Return code: 0 08:59:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:59:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:59:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:59:54 INFO - Return code: 0 08:59:54 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/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 08:59:54 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/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0110 --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 08:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FmGJZUDChk/Render', 08:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:54 INFO - 'HOME': '/Users/cltbld', 08:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:54 INFO - 'LOGNAME': 'cltbld', 08:59:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:54 INFO - 'MOZ_NO_REMOTE': '1', 08:59:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:54 INFO - 'NO_EM_RESTART': '1', 08:59:54 INFO - 'PAGER': '/bin/cat', 08:59:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:54 INFO - 'PWD': '/builds/slave/test', 08:59:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:54 INFO - 'SHELL': '/bin/bash', 08:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z2gwHMa1q3/Listeners', 08:59:54 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 08:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:54 INFO - 'USER': 'cltbld', 08:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:54 INFO - 'XPC_FLAGS': '0x0', 08:59:54 INFO - 'XPC_SERVICE_NAME': '0', 08:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:54 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/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 08:59:55 INFO - mozversion application_buildid: 20160317072613 08:59:55 INFO - mozversion application_changeset: 112cb0b69503ef77205124328c00fcc44a2297f3 08:59:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:59:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:55 INFO - mozversion application_name: Firefox 08:59:55 INFO - mozversion application_remotingname: firefox-dev 08:59:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:55 INFO - mozversion application_vendor: Mozilla 08:59:55 INFO - mozversion application_version: 47.0a2 08:59:55 INFO - mozversion platform_buildid: 20160317072613 08:59:55 INFO - mozversion platform_changeset: 112cb0b69503ef77205124328c00fcc44a2297f3 08:59:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:55 INFO - mozversion platform_version: 47.0a2 08:59:55 INFO - using testdate: 1458230395 08:59:55 INFO - actual date: 1458230395 08:59:55 INFO - starting webserver on 'localhost:49393' 08:59:55 INFO - SUITE-START | Running 2 tests 08:59:55 INFO - TEST-START | dromaeo_css 08:59:55 INFO - operating with platform_type : mac_ 08:59:55 INFO - Initialising browser for dromaeo_css test... 08:59:55 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpRYTvcv/profile http://localhost:49393/getInfo.html) 08:59:57 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 08:59:57 INFO - PROCESS | 2011 | colorDepth:24 08:59:57 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 08:59:57 INFO - PROCESS | 2011 | __metrics 08:59:57 INFO - PROCESS | 2011 | 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" 08:59:57 INFO - PROCESS | 2011 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:58 INFO - TEST-INFO | 2011: exit 0 08:59:58 INFO - Browser initialized. 08:59:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:58 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpRYTvcv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:10 INFO - PROCESS | 2013 | RSS: Main: 210952192 09:00:10 INFO - PROCESS | 2013 | 09:01:01 INFO - PROCESS | 2013 | 1458230461210 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] 09:03:11 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49393/tests/dromaeo/cssquery-ext.html) 09:03:12 INFO - PROCESS | 2013 | RSS: Main: 311623680 09:03:12 INFO - PROCESS | 2013 | 09:06:15 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-ext.html (next: http://localhost:49393/tests/dromaeo/cssquery-jquery.html) 09:06:15 INFO - PROCESS | 2013 | RSS: Main: 339628032 09:06:15 INFO - PROCESS | 2013 | 09:09:17 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49393/tests/dromaeo/cssquery-mootools.html) 09:09:18 INFO - PROCESS | 2013 | RSS: Main: 351457280 09:09:18 INFO - PROCESS | 2013 | 09:12:20 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49393/tests/dromaeo/cssquery-prototype.html) 09:12:21 INFO - PROCESS | 2013 | RSS: Main: 309600256 09:12:21 INFO - PROCESS | 2013 | 09:15:24 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49393/tests/dromaeo/cssquery-yui.html) 09:15:24 INFO - PROCESS | 2013 | RSS: Main: 313319424 09:15:24 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-yui.html (next: http://localhost:49393/tests/dromaeo/cssquery-dojo.html) 09:18:27 INFO - PROCESS | 2013 | RSS: Main: 376586240 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | __start_tp_report 09:18:27 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 09:18:27 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 09:18:27 INFO - PROCESS | 2013 | |i|pagename|runs| 09:18:27 INFO - PROCESS | 2013 | |0;dojo.html;2934.237098354428;3401.1327111586556;3425.1094715374;3435.1412146963257;3455.758096933214;5548.528375088117;5557.666540007603;5582.609217354787;5585.972070139649;5599.076152434848;5566.081596536566;5567.582431317657;5576.163575463673;5583.944160558393;5621.156826476021;5043.041822053798;5054.241863720435;5095.057414378333;5103.157978933472;5212.8436146915465;5139.434662187156;5182.300389447433;5238.397584277819;5241.5806735461265;5255.027819853321;5191.558717509016;5201.401838788531;5212.218167274901;5213.3743950725775;5219.817306394277;5222.582193424536;5275.70983595904;5281.392639846428;5317.627766056377;5320.920186197211;5018.447970723218;5178.533931946105;5196.714180720059;5200.323957885488;5208.947910520922;5630.8029218977545;5644.6613203207935;5646.830595082113;5671.262735844355;5678.148277758328;6134.9386506134815;6301.936980630181;6310.810675679737;6321.494280457552;6328.841778955563;6241.157443745127;6258.499320054385;6277.372262773732;6296.716647750863;6327;5840.240768700041;5859.4140585941495;5897.911531327033;5906.40935906406;5945.732442040118;6246.281677607133;6253.374662533801;6298.307186209513;6305.211848518935;6311.147995020705;6186.319504854462;6208.627482350983;6219.129321894939;6226.657533835682;6228;6280.120783090371;6289;6296.370362963758;6299.937000630027;6329.810105696836;6069.2716873975405;6184.783532576428;6196.0705894116245;6272.717727702265;6285.465735412449;6215.440610345;6240.687965601793;6264.780732674334;6267.2479302484;6312.873742525124;4927.556519913225;4929.260610908321;4932.605391568666;4942.604591632661;4945.4807245238735;4374.78126093694;4436.600705936481;4475.686701930834;4490.865274041784;4516.187086324428;5656.971715141398;5672.602917795797;5675.262215911987;5699.629524080921;5725.541956643458;6218.5647004709235;6253.499720022387;6259.561830671809;6263.843403914848;6270.529710271748;5660.660360378391;5669.830434044925;5694.288213973254;5696.060150075191;5707.543396528268;4452.910941781146;5252.868678282997;5340.439253878365;5375.892482150413;5392.379876314274;6331.176946996953;6336.049592561153;6343.968280158478;6350.714217860115;6360.300366959631;6238.407351301619;6258.561900667091;6262.812115636538;6274.498040156685;6296.716647750954;6225.875482490234;6267.749290028348;6293.213348331458;6300.180976473029;6380.649064301322;6192.133101365903;6240.968795155995;6241.531885108544;6254.124422580933;6272.529560282906;6283;6286.339934306832;6304.432601065926;6306.117143599808;6307.621542707452;4962.851114466572;6047.727852246571;6075.483583895419;6116.052011938156;6156.78451254204;6140.9078863816185;6162.722677479434;6167.198264225622;6167.444929956326;6168.290646575701;5873.3832947539895;6052.818415447544;6063.484603808725;6070.7875224366935;6075.969620152047;6115.6044591288555;6192.256929168529;6193.907091393543;6230.968845155745;6232.158658581034;5918.585699001201;6060;6078.300995385587;6080.148779171008;6098.237720284965 09:18:27 INFO - PROCESS | 2013 | |1;ext.html;485.8178183181307;566.9766072239606;608.7625825927886;631.4601016131206;666.2637785247301;27991.860040699794;38349.42475862861;38376;38383.61616383836;38427.23145537088;39475.21049579007;40051.399229011586;40091.398629020514;40133;40220;7922.6830926763005;9621.711348659517;9628.903710962872;9645.565949532287;9647.276454265922;9418.764530886749;9640.084192001783;9654.662086826927;9667.75830604237;9695.981921898205;9571.66499172529;9628.61485540581;9636.855447168264;9657.710268691915;9659.613615455373;9576.377535460208;9640.035996400375;9651.469169195692;9667.70996870095;9690.127888489998;9525.618975240983;9680.709578712649;9681.031896810333;9685.32202745808;9698.70903872885;39347.8032609838;39722.20555588872;39770.403443948366;39782.80108599467;39834.800825995975;3413.5562376891094;3451.9654803451895;3746.606606306353;3902.7853468059247;3914.432407300954;29659.110226693017;29682.812687492475;29697.257568560744;29739.553906691417;29996.85001574978;2771.9168424947284;2791.9441611167867;2805.523061079601;2838.4606924684244;2878.7265209805246;504738;505586;506352.4682376601;506849;509218;70266.64866675634;71525.6423717878;71596.64201678958;71615.64192179005;71653.64173179206;74032;78150;78183;78269.21730782733;78298;18225.908870455827;18506.167222475022;18527.907360463112;18539.629207415775;18559.25762969466;13765.931170344084;13858;13869.098508597112;13884.861151388559;13893.374798134108;22263.554728905656;22419.663705044437;22618.66072008921;22864.771352286265;22902.770972290396;8343.749687509384;9458.810823783486;9528.237740980705;9776.604731840745;9788.314817962817;915.4232833314969;974.3958745577787;1007.7934023525306;1078.094400703413;1084.2301965604508;24675.62986555203;30026.24934376658;30058.54912176319;30802.69197308043;30830.383392332027;1131.1403333466624;1145.9942700286613;1150.2121047082608;1210.2798834693344;1261.8643221101083;15199.924000380148;15219;15474.071555706694;15565.29956151976;15604.297806598503;561751;1084289.099763009;1091884;1096117;1098761;62454.687726561984;63023.68488157621;63138;63203;63249.68375158187;1165.9008984236266;1253.9373031348396;1534.8465153484563;1543.1898253417046;1648.1100205888686;23828.16601418942;23847.642285365386;29212.26969325784;29494.262643434085;30680.232994175323;51839.481605183464;52724.20913686221;52759;52764.20853687274;52770.736146319025;431964;433990;434247;434312;436309;26610.733892660824;31592;33781.83109084439;34070.48894266538;34126.63493460333;42567.787161064;44211.77894110509;44410.555894440644;45626.54373456223;45775;35474.64525354713;36014.09964750902;37059.6294037067;37247.88256352314;38147.42778858264;36937;37181.25637487289;37206.25587488289;37922;37990.43014354732;36481.087972800895;36584;36762.080947976516;37102;37941.62058379381;31938.36123277568;32388.352232954738;32713.672863271062;33261.833690831394;33352.49971250385;20264.79735202629;24957.625635615845;25259.242222733348;25327.017817349886;25401 09:18:27 INFO - PROCESS | 2013 | |2;jquery.html;381.47547122706277;387.3846061921787;388.99611003889953;389.52477976868227;394.4024802424326;15853.969491983042;16235.918820405881;19496.805031949676;21008.684869726967;21132.154713811447;12112.45493952772;15119.395224191047;20824.47938801531;20843.0620622072;20854.37436876896;5397.217403476494;5570.248016517779;5590.664560126405;5593.552515798747;5597.44025597441;4211.7262377945335;5546.112621980464;5631.07087330592;5961.046232602785;6214.62712237265;5565.6104072714925;5847.391967209009;6204.4105809948205;6213.875722485547;6218.067289906528;6173.722182501776;6401.615903045809;6554.901676474857;6756.729730810762;6760.492963027793;5902.6458412495385;5939.910901336483;5942;5944.197533332988;5957.225560677128;25303.493930121294;25694.486110277878;26583.867080664473;26625;26861.731382686117;2032.095717405755;2184.1263494602285;2246.472079061419;2442.1818690738623;2529.0263248649217;9805.068518490732;10200.285979981405;10220.284580079397;10288.331258468175;10300.536475858604;1752.3428714232164;1778.0309731196528;1814.2470874587032;1815.4190658989128;1865.850731941455;105678.41482377771;108318.45840770745;112472;113661;114660.99999999917;11438.370889601152;11596.710082248012;11640.06879449642;11698.590549330733;11915.16593838423;11850.585229516926;14382.993190476565;14427.422903083969;14484.927575362055;14500.782488262685;9066.365354425126;9100.08999100098;9198.264138868875;9217.815643687223;9353.812923741487;9517.23862091031;9519.52402379892;9550.522473876417;9597.952010239904;9612.51937403127;4693.084848454519;4765.0946320199055;4780.330753694486;4820.156472617278;4829.27560865873;1954.1108795498014;1993.5479360386805;2005.2079428625611;2025.929092481756;2039.9796002039789;807.9254591393433;888.5512816027865;1005.2309982863115;1050.8476270940823;1059.904608585231;16015;19325.51686207856;20715.171393144406;20931.790682093288;20983.37049888506;1012.4785735346303;1017.2472370445817;1022.2895087913829;1064.1752641702742;1074.1997212076897;9236.503868783584;10969.890301097046;11272.035914434451;11374.545018199346;11390.886091139148;583501;645543;658246;675543;676347;130384.348078259;130812.3459382697;133390;134781;138338;1057.3338796558273;1069.6897899609182;1069.8127827629978;1090.6673464593216;1094.5020015892749;18420;18630.16164272638;18661.066946652343;18825.90587047111;19293.710594341377;54514;55813;56307;57647.71176144092;58076;80621;83778;84049;84546.15453845629;85180;8031.867571646945;8234.876476852733;8238.134995825592;8247.422680412314;8785.989611194795;12744;13452.730945381234;13529.932350338579;13861.168329900238;13877.861221387657;8765.430247033923;8948.284137268873;11666.416679166177;11919.940400297943;12094.576689815814;11807.704807379885;11814.468348924147;11838.585649502225;11946.940265298617;12102.152849300464;9710.368826026286;11289.20975531705;12059.819102713642;12073.698157546132;12312.13815032939;8399.580020998803;8432.915670843213;8574.914250857411;8625.39622226438;8787.956060219658;11252.887471125512;12015.939920300343;12070.75858482843;12119.515219391478;12237.265764054186 09:18:27 INFO - PROCESS | 2013 | |3;mootools.html;1320.2474589483998;1492.492552532139;1657.3784830688496;1953.365156324195;2092.1003968293635;8080.353571714263;8812.295016398688;8975.820483590333;8981.056989016157;8985;8747.825043499126;8980.775480612989;8987.236084932772;8991.955040224806;8993.055729148427;2228.5988522066023;2489.6638953741285;2516.006177559863;2547.541442540342;2556.207575651554;2575.124457684387;2575.433404650974;2576.6521519594894;2579.187555919889;2579.6775403074616;2304.582681650781;2450.3996520852415;2560;2563.0772921748157;2563.9359016024655;2256.717910261217;2487.4154573675173;2512.57286261336;2541.9872900635564;2548.1081621432536;2499.487605040962;2516.735742747022;2563.192594332779;2568.75596818302;2573.073693470349;8846.115388461167;8936.46381217129;8936.597853096626;8943.329250306188;8989.685361012333;5498.147787093007;5612.971935140298;5613.7193140342815;5628.409017053192;5657.971710141423;3598.334308153;3658.8536458541626;3730.1420673245307;3754.699624030071;3756.1360886996144;1020.2246292817438;1043.1602559939247;1045.796069766396;1060.782539579392;1085.3704851186294;12630.30533320667;12668.68328291791;12683.365831708377;12684.936575317064;12696.873031269753;4705.905881882343;5056.469070747592;5130.97434512825;5136.9469258801855;5138.511841375063;10588.4705764713;10591.258611897247;10603.734906627396;10603.946980265204;10616.097631701392;5720.942790572041;5727.713614319351;5729.684867332337;5730.083186690193;5731.0543760279925;4477.059817438309;4490.550944905483;4631.560001799824;4635.559621835921;4642.442906851199;4039.757614543078;4084.550699423061;4153.813078411418;4165.021220013295;4169.874903752892;1126.8900133368625;1342.758303505359;1347.6981792160245;1348.8111664366998;1357.043284484436;1261.4071386448354;1384.5846246126323;1421.9075760075768;1454.985450145506;1457.358762144653;8458.87311690325;8559.22966932979;8561.871571926426;8598.914010859937;8694.17405346491;1247.607003793802;1250.443552619094;1254.5044707340733;1261.5710658376197;1267.5690265309838;6415.935840641627;6490.870182596322;6547.0179473079415;6547.148870646785;6548.246951600531;10718.89281107179;11035.72410689723;11136.610218642309;11148;11158.051565616852;10940.4529773511;11087.944560277308;11113.888861111285;11141.108711303077;11188.496517656726;8749.606267717969;8808.471491710518;8838.29293656506;8864.246539044254;8878.023417424078;8198.877016844872;8250.092489826235;8289.751307460785;8347.040090389683;8347.2487476125;10000.949995249977;10038.996100389902;10145.847812282675;10164.593416263267;10267.537960791633;10217.74455638615;10424.218183636409;10463.529141188512;10625.203109766953;10678.519466624177;5809.651420914759;6980.232174460907;7792.025996750406;7805.258500442449;7806.687732490636;7882.211778822072;8371.246587807127;8598.441101328393;8616.396852220536;8634.611442484978;7596.316331530189;7612.162662107275;7672.73145439907;7760.805979850549;7811.179826118176;7486.213947535431;7552.546847188966;7604.961975190088;7608.087029556267;7611.124720656974;6709.798706038827;8041.477303975223;8076.071251806117;8078.192180781874;8112.22933821286;7304.123505179413;7331.560106393634;7370.299821516947;7401.777946661608;7403.370713489198;7445.888311675221;7452.515586486861;7492.475526713078;7500.287472690085;7506.737264195727 09:18:27 INFO - PROCESS | 2013 | |4;prototype.html;332.3087977007824;337.32871585544757;344.02812055941956;345;348.6687646735602;6570.113034740309;6669.86660266795;6702.296258892819;6730.865382692343;6747.966260168699;6627.635480048595;6629.801105966817;6638.867222655544;6645.534812563123;6654.500912431563;4693.48371679115;4743.83396581118;4793.161196790547;4855;4977.925331120027;4838.129136755382;4842.515748425147;4860.465348811628;4867.513248675122;4891.16850135476;4009.278329900617;4791.928121078186;4797.088553174885;4867.464578896319;4875.512448755132;4644.140833945714;4761.571458568728;4864.440589332236;4873.756312184377;4874.853754387339;4180.72487891193;4181.268278051329;4189.601987811153;4206.221848957922;4218.261804184286;4809.879753006167;6376.29860715321;6434.292227854932;6436.806895793134;6465.3857883501;5880.6765627890445;5882.764689412418;5884.882302353929;5891.116332550109;5901.321348044987;6866.279040700704;7097.21930587635;7099.183593886717;7105.538140020882;7121.430285577141;4807.062622788558;4810.759462026885;4822.975885120587;4829.082474329901;4840.394950631171;7319.41444684424;7468.4025277977635;7471.066116735408;7487.288707572827;7508.1741008489025;4858.82994095205;4875.43932447773;4879.853604391874;4890.706557606555;4890.902181956341;4941.382327209099;4943.134951383494;4944.456109827916;4946.183879659816;4963.379577552806;4553.840615578439;5614.1859430382365;5814.825555233265;5827.854303642358;5839.795607153729;7081.327273908971;7113.857722845618;7119.537230080028;7120.287971202838;7134.036905017756;1695.7965044194775;1729.6713624411323;1732.2984191402502;1733.298014304209;1739.6433731085351;1061.840723891407;1094.578587243917;1122.6519778868576;1123.1015187849687;1150.4937827355936;6445.323241059715;6602.108715323466;6602.570832895846;6616.4376028037195;6617.8014659560295;7435.665395057235;7436.442266830009;7437.405007599379;7440;7444.553326800409;6555.901661475082;6582.17722784652;6583.30875258091;6589.967050164719;6596.703148358335;3755.5681096673684;3867.535895692479;3898.7855667938534;3916.5691773904846;3918.040080180374;7713.190115037953;7758;7767.883481747778;7776.961115194388;7778.183290754502;6485.7405703772265;7664.271894170045;7668.156502784689;7672.0409948756405;7677.769666910001;7740.032495938008;7756.340711039625;7758.456908016497;7774.922250777533;7778.222177782177;7090.184628767758;7379.3358597726465;7448.404127669665;7450.515716478411;7465.813354666177;7232.276772322725;7235.855282894207;7294.927050729637;7335.596542190231;7343.632818359168;7724.92275077242;7746.883796742941;7753.4960227585025;7755.457118001686;7765.48573028254;4681.414823147106;4738.526147385372;4745.5966242869745;4757.690750101232;4763.571278584944;7134;7428.628568571442;7437.181909989788;7439.181690014202;7444.069491313586;6476.222853257639;6885.4835887309655;7179.892301615376;7186.425085993003;7203.459740519586;7149.857002860018;7152.034475345762;7162.570245785269;7164.498485105993;7168.641567921479;6973.372396484341;6985.9301406987315;6995;7002.929970700227;7007.754728584475;6883.724651013903;7105.360517553445;7119.537230080028;7161.713531458683;7164.892526612;6665.466762658879;6761.087253220949;6868.62222577763;6885.2770459101075;6982.1272340957385 09:18:27 INFO - PROCESS | 2013 | |5;yui.html;713.6182142553733;718.4432065149507;739.9815004624887;760.4790718357925;788.0346575445077;15315.846841531582;15513;15519.767203491956;15523.301451434685;15526.922365388185;14328.71342573148;14517.128972261646;14536.273186340693;14552.199629020399;14559.708805823877;619.0744836469485;630.552307861419;964.1322809471496;985.6599473181741;986.3539381704994;975.3416443900375;984.807962447323;988.3081842710096;988.4909271725068;989.5448093876789;664.2361284522789;1045.8326667733165;1046.1473898772515;1046.1682962045193;1046.9895301047006;663.8838203314425;955.4697143085584;1035.829088200446;1037.092544023979;1041.7916416716687;770.5607803551977;770.865098607747;772.5712229712564;773.4392565390103;774.9690012399498;15189;15233.695326093417;15278.236088195657;15280.847191528053;15288.464903728316;12977.480900763958;13467.245603202651;13476.191428514223;13482;13725.588232353046;9716.562754676057;10347.63783267582;10442.738931526697;10496;10562.524686389132;3553.466979953002;3572.392693242129;3574.463830425431;3812.5424949006297;3827.6937844972613;74035.62982185108;74366.5126697463;74886.25113748848;77847;78532.21467785306;8882.86675699865;8961.59672814725;8965.820683586291;9028.909710902939;9052.773680657905;20917;20938.162473501194;20941.476463088544;20959.580808383747;20967.37097887066;7428;7463.9626801866725;7548.131964824115;7645.770626881203;7702;4177.4569305990635;4209.34755112958;4270;4369.628581570602;4463.933041004388;3632;3656.3784156693428;3664.230511592542;3669.0093674707678;3674.4855720199193;634.996825015872;645.5739212119978;650.3886346834056;656.6421300391298;668.4485299627827;518.7795187045491;581.880714453536;610.3438803286484;617.8826023055695;632.2665707778955;7776.416768742367;8364.707235246737;8512.74461766148;8514.04177039272;8636.136386361313;552.4447929830494;597.2981746447906;605.1467430922378;616.6485103491057;626.3016736338949;3470.722342212617;3689.317476266899;3887.922241555153;3914.784686842251;3991.6806655467494;80722.38555228863;82474;82493;95568;97386.5130674342;77481.61259193668;77680.22319776843;78875;79335.20664793394;79582;70871.64564177147;71993;72033.91949120768;72648.63675681694;73888.1527961816;8525.829483410422;8637.56812159402;8678.78303042429;8730.476171429735;8869.379143459895;49092.509074910224;50348.49651503438;51662.48337516727;52633.94732105413;52690.94618107693;65974.01038984515;67806;70133.54108610941;70683.9397409029;70989.64505177441;10963.725906852393;11309.943450283025;11312.60405885823;11473.311601303949;11523.769524609628;9686.467244301632;11927;12119.939400302943;12420.689482762642;12759.74480510366;11243.325400475998;11548.249363791327;11638.359890205782;11726.765464690829;11839.58561450345;11691.532338706356;11808.46118084616;12005.39973001364;12073.637790866289;12081.57714479989;11138.610148644759;11588.710282243012;11694.70763230926;11861.40692965331;11881.702957425789;9866.210703143588;9907.0808733211;9943.651972180938;9954.751131221488;10243.692689219335;9801.705948821547;9812;9851.408915465096;9934;9935.552900119368 09:18:27 INFO - PROCESS | 2013 | __end_tp_report 09:18:27 INFO - PROCESS | 2013 | __start_cc_report 09:18:27 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,1035 09:18:27 INFO - PROCESS | 2013 | __end_cc_report 09:18:27 INFO - PROCESS | 2013 | __startTimestamp1458231507761__endTimestamp 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | ------- Summary: start ------- 09:18:27 INFO - PROCESS | 2013 | Number of tests: 6 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#0] dojo.html Cycles:165 Average:5749.67 Median:6069.27 stddev:669.46 (11.0%) stddev-sans-first:634.03 09:18:27 INFO - PROCESS | 2013 | Values: 2934.2 3401.1 3425.1 3435.1 3455.8 5548.5 5557.7 5582.6 5586.0 5599.1 5566.1 5567.6 5576.2 5583.9 5621.2 5043.0 5054.2 5095.1 5103.2 5212.8 5139.4 5182.3 5238.4 5241.6 5255.0 5191.6 5201.4 5212.2 5213.4 5219.8 5222.6 5275.7 5281.4 5317.6 5320.9 5018.4 5178.5 5196.7 5200.3 5208.9 5630.8 5644.7 5646.8 5671.3 5678.1 6134.9 6301.9 6310.8 6321.5 6328.8 6241.2 6258.5 6277.4 6296.7 6327.0 5840.2 5859.4 5897.9 5906.4 5945.7 6246.3 6253.4 6298.3 6305.2 6311.1 6186.3 6208.6 6219.1 6226.7 6228.0 6280.1 6289.0 6296.4 6299.9 6329.8 6069.3 6184.8 6196.1 6272.7 6285.5 6215.4 6240.7 6264.8 6267.2 6312.9 4927.6 4929.3 4932.6 4942.6 4945.5 4374.8 4436.6 4475.7 4490.9 4516.2 5657.0 5672.6 5675.3 5699.6 5725.5 6218.6 6253.5 6259.6 6263.8 6270.5 5660.7 5669.8 5694.3 5696.1 5707.5 4452.9 5252.9 5340.4 5375.9 5392.4 6331.2 6336.0 6344.0 6350.7 6360.3 6238.4 6258.6 6262.8 6274.5 6296.7 6225.9 6267.7 6293.2 6300.2 6380.6 6192.1 6241.0 6241.5 6254.1 6272.5 6283.0 6286.3 6304.4 6306.1 6307.6 4962.9 6047.7 6075.5 6116.1 6156.8 6140.9 6162.7 6167.2 6167.4 6168.3 5873.4 6052.8 6063.5 6070.8 6076.0 6115.6 6192.3 6193.9 6231.0 6232.2 5918.6 6060.0 6078.3 6080.1 6098.2 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#1] ext.html Cycles:180 Average:77139.98 Median:38248.43 stddev:189442.63 (495.3%) stddev-sans-first:189886.64 09:18:27 INFO - PROCESS | 2013 | Values: 485.8 567.0 608.8 631.5 666.3 27991.9 38349.4 38376.0 38383.6 38427.2 39475.2 40051.4 40091.4 40133.0 40220.0 7922.7 9621.7 9628.9 9645.6 9647.3 9418.8 9640.1 9654.7 9667.8 9696.0 9571.7 9628.6 9636.9 9657.7 9659.6 9576.4 9640.0 9651.5 9667.7 9690.1 9525.6 9680.7 9681.0 9685.3 9698.7 39347.8 39722.2 39770.4 39782.8 39834.8 3413.6 3452.0 3746.6 3902.8 3914.4 29659.1 29682.8 29697.3 29739.6 29996.9 2771.9 2791.9 2805.5 2838.5 2878.7 504738.0 505586.0 506352.5 506849.0 509218.0 70266.6 71525.6 71596.6 71615.6 71653.6 74032.0 78150.0 78183.0 78269.2 78298.0 18225.9 18506.2 18527.9 18539.6 18559.3 13765.9 13858.0 13869.1 13884.9 13893.4 22263.6 22419.7 22618.7 22864.8 22902.8 8343.7 9458.8 9528.2 9776.6 9788.3 915.4 974.4 1007.8 1078.1 1084.2 24675.6 30026.2 30058.5 30802.7 30830.4 1131.1 1146.0 1150.2 1210.3 1261.9 15199.9 15219.0 15474.1 15565.3 15604.3 561751.0 1084289.1 1091884.0 1096117.0 1098761.0 62454.7 63023.7 63138.0 63203.0 63249.7 1165.9 1253.9 1534.8 1543.2 1648.1 23828.2 23847.6 29212.3 29494.3 30680.2 51839.5 52724.2 52759.0 52764.2 52770.7 431964.0 433990.0 434247.0 434312.0 436309.0 26610.7 31592.0 33781.8 34070.5 34126.6 42567.8 44211.8 44410.6 45626.5 45775.0 35474.6 36014.1 37059.6 37247.9 38147.4 36937.0 37181.3 37206.3 37922.0 37990.4 36481.1 36584.0 36762.1 37102.0 37941.6 31938.4 32388.4 32713.7 33261.8 33352.5 20264.8 24957.6 25259.2 25327.0 25401.0 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#2] jquery.html Cycles:180 Average:36647.49 Median:20957.58 stddev:107897.95 (514.8%) stddev-sans-first:108166.27 09:18:27 INFO - PROCESS | 2013 | Values: 381.5 387.4 389.0 389.5 394.4 15854.0 16235.9 19496.8 21008.7 21132.2 12112.5 15119.4 20824.5 20843.1 20854.4 5397.2 5570.2 5590.7 5593.6 5597.4 4211.7 5546.1 5631.1 5961.0 6214.6 5565.6 5847.4 6204.4 6213.9 6218.1 6173.7 6401.6 6554.9 6756.7 6760.5 5902.6 5939.9 5942.0 5944.2 5957.2 25303.5 25694.5 26583.9 26625.0 26861.7 2032.1 2184.1 2246.5 2442.2 2529.0 9805.1 10200.3 10220.3 10288.3 10300.5 1752.3 1778.0 1814.2 1815.4 1865.9 105678.4 108318.5 112472.0 113661.0 114661.0 11438.4 11596.7 11640.1 11698.6 11915.2 11850.6 14383.0 14427.4 14484.9 14500.8 9066.4 9100.1 9198.3 9217.8 9353.8 9517.2 9519.5 9550.5 9598.0 9612.5 4693.1 4765.1 4780.3 4820.2 4829.3 1954.1 1993.5 2005.2 2025.9 2040.0 807.9 888.6 1005.2 1050.8 1059.9 16015.0 19325.5 20715.2 20931.8 20983.4 1012.5 1017.2 1022.3 1064.2 1074.2 9236.5 10969.9 11272.0 11374.5 11390.9 583501.0 645543.0 658246.0 675543.0 676347.0 130384.3 130812.3 133390.0 134781.0 138338.0 1057.3 1069.7 1069.8 1090.7 1094.5 18420.0 18630.2 18661.1 18825.9 19293.7 54514.0 55813.0 56307.0 57647.7 58076.0 80621.0 83778.0 84049.0 84546.2 85180.0 8031.9 8234.9 8238.1 8247.4 8786.0 12744.0 13452.7 13529.9 13861.2 13877.9 8765.4 8948.3 11666.4 11919.9 12094.6 11807.7 11814.5 11838.6 11946.9 12102.2 9710.4 11289.2 12059.8 12073.7 12312.1 8399.6 8432.9 8574.9 8625.4 8788.0 11252.9 12015.9 12070.8 12119.5 12237.3 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#3] mootools.html Cycles:180 Average:6289.91 Median:4483.81 stddev:3339.18 (74.5%) stddev-sans-first:3327.64 09:18:27 INFO - PROCESS | 2013 | Values: 1320.2 1492.5 1657.4 1953.4 2092.1 8080.4 8812.3 8975.8 8981.1 8985.0 8747.8 8980.8 8987.2 8992.0 8993.1 2228.6 2489.7 2516.0 2547.5 2556.2 2575.1 2575.4 2576.7 2579.2 2579.7 2304.6 2450.4 2560.0 2563.1 2563.9 2256.7 2487.4 2512.6 2542.0 2548.1 2499.5 2516.7 2563.2 2568.8 2573.1 8846.1 8936.5 8936.6 8943.3 8989.7 5498.1 5613.0 5613.7 5628.4 5658.0 3598.3 3658.9 3730.1 3754.7 3756.1 1020.2 1043.2 1045.8 1060.8 1085.4 12630.3 12668.7 12683.4 12684.9 12696.9 4705.9 5056.5 5131.0 5136.9 5138.5 10588.5 10591.3 10603.7 10603.9 10616.1 5720.9 5727.7 5729.7 5730.1 5731.1 4477.1 4490.6 4631.6 4635.6 4642.4 4039.8 4084.6 4153.8 4165.0 4169.9 1126.9 1342.8 1347.7 1348.8 1357.0 1261.4 1384.6 1421.9 1455.0 1457.4 8458.9 8559.2 8561.9 8598.9 8694.2 1247.6 1250.4 1254.5 1261.6 1267.6 6415.9 6490.9 6547.0 6547.1 6548.2 10718.9 11035.7 11136.6 11148.0 11158.1 10940.5 11087.9 11113.9 11141.1 11188.5 8749.6 8808.5 8838.3 8864.2 8878.0 8198.9 8250.1 8289.8 8347.0 8347.2 10000.9 10039.0 10145.8 10164.6 10267.5 10217.7 10424.2 10463.5 10625.2 10678.5 5809.7 6980.2 7792.0 7805.3 7806.7 7882.2 8371.2 8598.4 8616.4 8634.6 7596.3 7612.2 7672.7 7760.8 7811.2 7486.2 7552.5 7605.0 7608.1 7611.1 6709.8 8041.5 8076.1 8078.2 8112.2 7304.1 7331.6 7370.3 7401.8 7403.4 7445.9 7452.5 7492.5 7500.3 7506.7 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#4] prototype.html Cycles:180 Average:5850.98 Median:6609.50 stddev:1860.10 (28.1%) stddev-sans-first:1818.62 09:18:27 INFO - PROCESS | 2013 | Values: 332.3 337.3 344.0 345.0 348.7 6570.1 6669.9 6702.3 6730.9 6748.0 6627.6 6629.8 6638.9 6645.5 6654.5 4693.5 4743.8 4793.2 4855.0 4977.9 4838.1 4842.5 4860.5 4867.5 4891.2 4009.3 4791.9 4797.1 4867.5 4875.5 4644.1 4761.6 4864.4 4873.8 4874.9 4180.7 4181.3 4189.6 4206.2 4218.3 4809.9 6376.3 6434.3 6436.8 6465.4 5880.7 5882.8 5884.9 5891.1 5901.3 6866.3 7097.2 7099.2 7105.5 7121.4 4807.1 4810.8 4823.0 4829.1 4840.4 7319.4 7468.4 7471.1 7487.3 7508.2 4858.8 4875.4 4879.9 4890.7 4890.9 4941.4 4943.1 4944.5 4946.2 4963.4 4553.8 5614.2 5814.8 5827.9 5839.8 7081.3 7113.9 7119.5 7120.3 7134.0 1695.8 1729.7 1732.3 1733.3 1739.6 1061.8 1094.6 1122.7 1123.1 1150.5 6445.3 6602.1 6602.6 6616.4 6617.8 7435.7 7436.4 7437.4 7440.0 7444.6 6555.9 6582.2 6583.3 6590.0 6596.7 3755.6 3867.5 3898.8 3916.6 3918.0 7713.2 7758.0 7767.9 7777.0 7778.2 6485.7 7664.3 7668.2 7672.0 7677.8 7740.0 7756.3 7758.5 7774.9 7778.2 7090.2 7379.3 7448.4 7450.5 7465.8 7232.3 7235.9 7294.9 7335.6 7343.6 7724.9 7746.9 7753.5 7755.5 7765.5 4681.4 4738.5 4745.6 4757.7 4763.6 7134.0 7428.6 7437.2 7439.2 7444.1 6476.2 6885.5 7179.9 7186.4 7203.5 7149.9 7152.0 7162.6 7164.5 7168.6 6973.4 6985.9 6995.0 7002.9 7007.8 6883.7 7105.4 7119.5 7161.7 7164.9 6665.5 6761.1 6868.6 6885.3 6982.1 09:18:27 INFO - PROCESS | 2013 | 09:18:27 INFO - PROCESS | 2013 | [#5] yui.html Cycles:180 Average:18307.60 Median:607.75 stddev:25293.02 (4161.8%) stddev-sans-first:25329.47 09:18:27 INFO - PROCESS | 2013 | Values: 713.6 718.4 740.0 760.5 788.0 15315.8 15513.0 15519.8 15523.3 15526.9 14328.7 14517.1 14536.3 14552.2 14559.7 619.1 630.6 964.1 985.7 986.4 975.3 984.8 988.3 988.5 989.5 664.2 1045.8 1046.1 1046.2 1047.0 663.9 955.5 1035.8 1037.1 1041.8 770.6 770.9 772.6 773.4 775.0 15189.0 15233.7 15278.2 15280.8 15288.5 12977.5 13467.2 13476.2 13482.0 13725.6 9716.6 10347.6 10442.7 10496.0 10562.5 3553.5 3572.4 3574.5 3812.5 3827.7 74035.6 74366.5 74886.3 77847.0 78532.2 8882.9 8961.6 8965.8 9028.9 9052.8 20917.0 20938.2 20941.5 20959.6 20967.4 7428.0 7464.0 7548.1 7645.8 7702.0 4177.5 4209.3 4270.0 4369.6 4463.9 3632.0 3656.4 3664.2 3669.0 3674.5 635.0 645.6 650.4 656.6 668.4 518.8 581.9 610.3 617.9 632.3 7776.4 8364.7 8512.7 8514.0 8636.1 552.4 597.3 605.1 616.6 626.3 3470.7 3689.3 3887.9 3914.8 3991.7 80722.4 82474.0 82493.0 95568.0 97386.5 77481.6 77680.2 78875.0 79335.2 79582.0 70871.6 71993.0 72033.9 72648.6 73888.2 8525.8 8637.6 8678.8 8730.5 8869.4 49092.5 50348.5 51662.5 52633.9 52690.9 65974.0 67806.0 70133.5 70683.9 70989.6 10963.7 11309.9 11312.6 11473.3 11523.8 9686.5 11927.0 12119.9 12420.7 12759.7 11243.3 11548.2 11638.4 11726.8 11839.6 11691.5 11808.5 12005.4 12073.6 12081.6 11138.6 11588.7 11694.7 11861.4 11881.7 9866.2 9907.1 9943.7 9954.8 10243.7 9801.7 9812.0 9851.4 9934.0 9935.6 09:18:27 INFO - PROCESS | 2013 | -------- Summary: end -------- 09:18:27 INFO - PROCESS | 2013 | 09:18:28 INFO - TEST-INFO | 2013: exit 0 09:18:28 INFO - TEST-OK | dromaeo_css | took 1113247ms 09:18:28 INFO - TEST-START | kraken 09:18:28 INFO - operating with platform_type : mac_ 09:18:28 INFO - Initialising browser for kraken test... 09:18:28 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpAAa4zu/profile http://localhost:49393/getInfo.html) 09:18:30 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 09:18:30 INFO - PROCESS | 2016 | colorDepth:24 09:18:30 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 09:18:30 INFO - PROCESS | 2016 | __metrics 09:18:30 INFO - PROCESS | 2016 | 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" 09:18:30 INFO - PROCESS | 2016 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:31 INFO - TEST-INFO | 2016: exit 0 09:18:31 INFO - Browser initialized. 09:18:31 INFO - Running cycle 1/1 for kraken test... 09:18:31 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpAAa4zu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:43 INFO - PROCESS | 2018 | RSS: Main: 210845696 09:18:43 INFO - PROCESS | 2018 | 09:18:45 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:46 INFO - PROCESS | 2018 | RSS: Main: 266031104 09:18:46 INFO - PROCESS | 2018 | 09:18:48 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-dft) 09:18:49 INFO - PROCESS | 2018 | RSS: Main: 277159936 09:18:49 INFO - PROCESS | 2018 | 09:18:52 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-fft) 09:18:53 INFO - PROCESS | 2018 | RSS: Main: 264855552 09:18:53 INFO - PROCESS | 2018 | 09:18:55 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator) 09:18:55 INFO - PROCESS | 2018 | RSS: Main: 266170368 09:18:55 INFO - PROCESS | 2018 | 09:18:57 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:58 INFO - PROCESS | 2018 | RSS: Main: 266997760 09:18:58 INFO - PROCESS | 2018 | 09:19:01 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:01 INFO - PROCESS | 2018 | RSS: Main: 268054528 09:19:01 INFO - PROCESS | 2018 | 09:19:04 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:05 INFO - PROCESS | 2018 | RSS: Main: 267079680 09:19:05 INFO - PROCESS | 2018 | 09:19:08 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial) 09:19:08 INFO - PROCESS | 2018 | RSS: Main: 266334208 09:19:08 INFO - PROCESS | 2018 | 09:19:10 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:10 INFO - PROCESS | 2018 | RSS: Main: 300388352 09:19:10 INFO - PROCESS | 2018 | 09:19:12 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:13 INFO - PROCESS | 2018 | RSS: Main: 300695552 09:19:13 INFO - PROCESS | 2018 | 09:19:15 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:15 INFO - PROCESS | 2018 | RSS: Main: 308318208 09:19:15 INFO - PROCESS | 2018 | 09:19:18 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:19 INFO - PROCESS | 2018 | RSS: Main: 309329920 09:19:19 INFO - PROCESS | 2018 | 09:19:21 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:22 INFO - PROCESS | 2018 | RSS: Main: 310738944 09:19:22 INFO - PROCESS | 2018 | 09:19:23 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49393/tests/kraken/driver.html?testName=ai-astar) 09:19:24 INFO - PROCESS | 2018 | RSS: Main: 369381376 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | __start_tp_report 09:19:24 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 09:19:24 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 09:19:24 INFO - PROCESS | 2018 | |i|pagename|runs| 09:19:24 INFO - PROCESS | 2018 | |0;ai-astar;113;110;110;111;113;111;120;109;111;112 09:19:24 INFO - PROCESS | 2018 | |1;audio-beat-detection;153;119;154;146;153;173;108;185;179;111 09:19:24 INFO - PROCESS | 2018 | |2;audio-dft;184;182;201;264;203;186;186;184;185;186 09:19:24 INFO - PROCESS | 2018 | |3;audio-fft;71;79;73;123;56;56;59;59;125;57 09:19:24 INFO - PROCESS | 2018 | |4;audio-oscillator;90;96;128;78;76;89;115;76;79;111 09:19:24 INFO - PROCESS | 2018 | |5;imaging-gaussian-blur;108;84;88;85;87;85;88;84;86;85 09:19:24 INFO - PROCESS | 2018 | |6;imaging-darkroom;92;92;92;107;149;109;92;108;133;115 09:19:24 INFO - PROCESS | 2018 | |7;imaging-desaturate;81;84;86;87;87;87;85;86;88;84 09:19:24 INFO - PROCESS | 2018 | |8;json-parse-financial;56;58;61;58;58;59;59;67;50;49 09:19:24 INFO - PROCESS | 2018 | |9;json-stringify-tinderbox;62;65;79;72;70;66;68;67;68;68 09:19:24 INFO - PROCESS | 2018 | |10;stanford-crypto-aes;80;80;81;79;79;79;80;79;82;83 09:19:24 INFO - PROCESS | 2018 | |11;stanford-crypto-ccm;130;104;120;98;123;128;128;127;125;119 09:19:24 INFO - PROCESS | 2018 | |12;stanford-crypto-pbkdf2;152;132;134;132;134;121;132;131;131;133 09:19:24 INFO - PROCESS | 2018 | |13;stanford-crypto-sha256-iterative;64;67;65;65;66;63;85;96;93;68 09:19:24 INFO - PROCESS | 2018 | __end_tp_report 09:19:24 INFO - PROCESS | 2018 | __start_cc_report 09:19:24 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,1231 09:19:24 INFO - PROCESS | 2018 | __end_cc_report 09:19:24 INFO - PROCESS | 2018 | __startTimestamp1458231564125__endTimestamp 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | ------- Summary: start ------- 09:19:24 INFO - PROCESS | 2018 | Number of tests: 14 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:3.09 (2.8%) stddev-sans-first:3.26 09:19:24 INFO - PROCESS | 2018 | Values: 113.0 110.0 110.0 111.0 113.0 111.0 120.0 109.0 111.0 112.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.50 stddev:27.60 (18.0%) stddev-sans-first:29.22 09:19:24 INFO - PROCESS | 2018 | Values: 153.0 119.0 154.0 146.0 153.0 173.0 108.0 185.0 179.0 111.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#2] audio-dft Cycles:10 Average:196.10 Median:186.00 stddev:24.95 (13.4%) stddev-sans-first:26.08 09:19:24 INFO - PROCESS | 2018 | Values: 184.0 182.0 201.0 264.0 203.0 186.0 186.0 184.0 185.0 186.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#3] audio-fft Cycles:10 Average:75.80 Median:59.00 stddev:26.65 (45.2%) stddev-sans-first:28.21 09:19:24 INFO - PROCESS | 2018 | Values: 71.0 79.0 73.0 123.0 56.0 56.0 59.0 59.0 125.0 57.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.50 stddev:18.44 (23.5%) stddev-sans-first:19.50 09:19:24 INFO - PROCESS | 2018 | Values: 90.0 96.0 128.0 78.0 76.0 89.0 115.0 76.0 79.0 111.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:85.50 stddev:7.18 (8.4%) stddev-sans-first:1.56 09:19:24 INFO - PROCESS | 2018 | Values: 108.0 84.0 88.0 85.0 87.0 85.0 88.0 84.0 86.0 85.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:120.50 stddev:19.36 (16.1%) stddev-sans-first:19.54 09:19:24 INFO - PROCESS | 2018 | Values: 92.0 92.0 92.0 107.0 149.0 109.0 92.0 108.0 133.0 115.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.50 stddev:2.07 (2.4%) stddev-sans-first:1.41 09:19:24 INFO - PROCESS | 2018 | Values: 81.0 84.0 86.0 87.0 87.0 87.0 85.0 86.0 88.0 84.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.50 stddev:5.15 (8.8%) stddev-sans-first:5.43 09:19:24 INFO - PROCESS | 2018 | Values: 56.0 58.0 61.0 58.0 58.0 59.0 59.0 67.0 50.0 49.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:4.58 (6.7%) stddev-sans-first:4.21 09:19:24 INFO - PROCESS | 2018 | Values: 62.0 65.0 79.0 72.0 70.0 66.0 68.0 67.0 68.0 68.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.40 (1.7%) stddev-sans-first:1.48 09:19:24 INFO - PROCESS | 2018 | Values: 80.0 80.0 81.0 79.0 79.0 79.0 80.0 79.0 82.0 83.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:127.50 stddev:10.81 (8.5%) stddev-sans-first:10.87 09:19:24 INFO - PROCESS | 2018 | Values: 130.0 104.0 120.0 98.0 123.0 128.0 128.0 127.0 125.0 119.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.20 Median:132.50 stddev:7.58 (5.7%) stddev-sans-first:3.95 09:19:24 INFO - PROCESS | 2018 | Values: 152.0 132.0 134.0 132.0 134.0 121.0 132.0 131.0 131.0 133.0 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - PROCESS | 2018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:67.50 stddev:12.87 (19.1%) stddev-sans-first:13.22 09:19:24 INFO - PROCESS | 2018 | Values: 64.0 67.0 65.0 65.0 66.0 63.0 85.0 96.0 93.0 68.0 09:19:24 INFO - PROCESS | 2018 | -------- Summary: end -------- 09:19:24 INFO - PROCESS | 2018 | 09:19:24 INFO - TEST-INFO | 2018: exit 0 09:19:24 INFO - TEST-OK | kraken | took 56535ms 09:19:24 INFO - SUITE-END | took 1169s 09:19:25 INFO - Completed test suite (00:19:30) 09:19:25 INFO - javascript benchmark 09:19:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2934.237098354428, 3401.1327111586556, 3425.1094715374, 3435.1412146963257, 3455.758096933214, 5548.528375088117, 5557.666540007603, 5582.609217354787, 5585.972070139649, 5599.076152434848, 5566.081596536566, 5567.582431317657, 5576.163575463673, 5583.944160558393, 5621.156826476021, 5043.041822053798, 5054.241863720435, 5095.057414378333, 5103.157978933472, 5212.8436146915465, 5139.434662187156, 5182.300389447433, 5238.397584277819, 5241.5806735461265, 5255.027819853321, 5191.558717509016, 5201.401838788531, 5212.218167274901, 5213.3743950725775, 5219.817306394277, 5222.582193424536, 5275.70983595904, 5281.392639846428, 5317.627766056377, 5320.920186197211, 5018.447970723218, 5178.533931946105, 5196.714180720059, 5200.323957885488, 5208.947910520922, 5630.8029218977545, 5644.6613203207935, 5646.830595082113, 5671.262735844355, 5678.148277758328, 6134.9386506134815, 6301.936980630181, 6310.810675679737, 6321.494280457552, 6328.841778955563, 6241.157443745127, 6258.499320054385, 6277.372262773732, 6296.716647750863, 6327.0, 5840.240768700041, 5859.4140585941495, 5897.911531327033, 5906.40935906406, 5945.732442040118, 6246.281677607133, 6253.374662533801, 6298.307186209513, 6305.211848518935, 6311.147995020705, 6186.319504854462, 6208.627482350983, 6219.129321894939, 6226.657533835682, 6228.0, 6280.120783090371, 6289.0, 6296.370362963758, 6299.937000630027, 6329.810105696836, 6069.2716873975405, 6184.783532576428, 6196.0705894116245, 6272.717727702265, 6285.465735412449, 6215.440610345, 6240.687965601793, 6264.780732674334, 6267.2479302484, 6312.873742525124, 4927.556519913225, 4929.260610908321, 4932.605391568666, 4942.604591632661, 4945.4807245238735, 4374.78126093694, 4436.600705936481, 4475.686701930834, 4490.865274041784, 4516.187086324428, 5656.971715141398, 5672.602917795797, 5675.262215911987, 5699.629524080921, 5725.541956643458, 6218.5647004709235, 6253.499720022387, 6259.561830671809, 6263.843403914848, 6270.529710271748, 5660.660360378391, 5669.830434044925, 5694.288213973254, 5696.060150075191, 5707.543396528268, 4452.910941781146, 5252.868678282997, 5340.439253878365, 5375.892482150413, 5392.379876314274, 6331.176946996953, 6336.049592561153, 6343.968280158478, 6350.714217860115, 6360.300366959631, 6238.407351301619, 6258.561900667091, 6262.812115636538, 6274.498040156685, 6296.716647750954, 6225.875482490234, 6267.749290028348, 6293.213348331458, 6300.180976473029, 6380.649064301322, 6192.133101365903, 6240.968795155995, 6241.531885108544, 6254.124422580933, 6272.529560282906, 6283.0, 6286.339934306832, 6304.432601065926, 6306.117143599808, 6307.621542707452, 4962.851114466572, 6047.727852246571, 6075.483583895419, 6116.052011938156, 6156.78451254204, 6140.9078863816185, 6162.722677479434, 6167.198264225622, 6167.444929956326, 6168.290646575701, 5873.3832947539895, 6052.818415447544, 6063.484603808725, 6070.7875224366935, 6075.969620152047, 6115.6044591288555, 6192.256929168529, 6193.907091393543, 6230.968845155745, 6232.158658581034, 5918.585699001201, 6060.0, 6078.300995385587, 6080.148779171008, 6098.237720284965], "unit": "score", "name": "dojo.html", "value": 5705.074472878072}, {"lowerIsBetter": false, "replicates": [485.8178183181307, 566.9766072239606, 608.7625825927886, 631.4601016131206, 666.2637785247301, 27991.860040699794, 38349.42475862861, 38376.0, 38383.61616383836, 38427.23145537088, 39475.21049579007, 40051.399229011586, 40091.398629020514, 40133.0, 40220.0, 7922.6830926763005, 9621.711348659517, 9628.903710962872, 9645.565949532287, 9647.276454265922, 9418.764530886749, 9640.084192001783, 9654.662086826927, 9667.75830604237, 9695.981921898205, 9571.66499172529, 9628.61485540581, 9636.855447168264, 9657.710268691915, 9659.613615455373, 9576.377535460208, 9640.035996400375, 9651.469169195692, 9667.70996870095, 9690.127888489998, 9525.618975240983, 9680.709578712649, 9681.031896810333, 9685.32202745808, 9698.70903872885, 39347.8032609838, 39722.20555588872, 39770.403443948366, 39782.80108599467, 39834.800825995975, 3413.5562376891094, 3451.9654803451895, 3746.606606306353, 3902.7853468059247, 3914.432407300954, 29659.110226693017, 29682.812687492475, 29697.257568560744, 29739.553906691417, 29996.85001574978, 2771.9168424947284, 2791.9441611167867, 2805.523061079601, 2838.4606924684244, 2878.7265209805246, 504738.0, 505586.0, 506352.4682376601, 506849.0, 509218.0, 70266.64866675634, 71525.6423717878, 71596.64201678958, 71615.64192179005, 71653.64173179206, 74032.0, 78150.0, 78183.0, 78269.21730782733, 78298.0, 18225.908870455827, 18506.167222475022, 18527.907360463112, 18539.629207415775, 18559.25762969466, 13765.931170344084, 13858.0, 13869.098508597112, 13884.861151388559, 13893.374798134108, 22263.554728905656, 22419.663705044437, 22618.66072008921, 22864.771352286265, 22902.770972290396, 8343.749687509384, 9458.810823783486, 9528.237740980705, 9776.604731840745, 9788.314817962817, 915.4232833314969, 974.3958745577787, 1007.7934023525306, 1078.094400703413, 1084.2301965604508, 24675.62986555203, 30026.24934376658, 30058.54912176319, 30802.69197308043, 30830.383392332027, 1131.1403333466624, 1145.9942700286613, 1150.2121047082608, 1210.2798834693344, 1261.8643221101083, 15199.924000380148, 15219.0, 15474.071555706694, 15565.29956151976, 15604.297806598503, 561751.0, 1084289.099763009, 1091884.0, 1096117.0, 1098761.0, 62454.687726561984, 63023.68488157621, 63138.0, 63203.0, 63249.68375158187, 1165.9008984236266, 1253.9373031348396, 1534.8465153484563, 1543.1898253417046, 1648.1100205888686, 23828.16601418942, 23847.642285365386, 29212.26969325784, 29494.262643434085, 30680.232994175323, 51839.481605183464, 52724.20913686221, 52759.0, 52764.20853687274, 52770.736146319025, 431964.0, 433990.0, 434247.0, 434312.0, 436309.0, 26610.733892660824, 31592.0, 33781.83109084439, 34070.48894266538, 34126.63493460333, 42567.787161064, 44211.77894110509, 44410.555894440644, 45626.54373456223, 45775.0, 35474.64525354713, 36014.09964750902, 37059.6294037067, 37247.88256352314, 38147.42778858264, 36937.0, 37181.25637487289, 37206.25587488289, 37922.0, 37990.43014354732, 36481.087972800895, 36584.0, 36762.080947976516, 37102.0, 37941.62058379381, 31938.36123277568, 32388.352232954738, 32713.672863271062, 33261.833690831394, 33352.49971250385, 20264.79735202629, 24957.625635615845, 25259.242222733348, 25327.017817349886, 25401.0], "unit": "score", "name": "ext.html", "value": 20663.007674108787}, {"lowerIsBetter": false, "replicates": [381.47547122706277, 387.3846061921787, 388.99611003889953, 389.52477976868227, 394.4024802424326, 15853.969491983042, 16235.918820405881, 19496.805031949676, 21008.684869726967, 21132.154713811447, 12112.45493952772, 15119.395224191047, 20824.47938801531, 20843.0620622072, 20854.37436876896, 5397.217403476494, 5570.248016517779, 5590.664560126405, 5593.552515798747, 5597.44025597441, 4211.7262377945335, 5546.112621980464, 5631.07087330592, 5961.046232602785, 6214.62712237265, 5565.6104072714925, 5847.391967209009, 6204.4105809948205, 6213.875722485547, 6218.067289906528, 6173.722182501776, 6401.615903045809, 6554.901676474857, 6756.729730810762, 6760.492963027793, 5902.6458412495385, 5939.910901336483, 5942.0, 5944.197533332988, 5957.225560677128, 25303.493930121294, 25694.486110277878, 26583.867080664473, 26625.0, 26861.731382686117, 2032.095717405755, 2184.1263494602285, 2246.472079061419, 2442.1818690738623, 2529.0263248649217, 9805.068518490732, 10200.285979981405, 10220.284580079397, 10288.331258468175, 10300.536475858604, 1752.3428714232164, 1778.0309731196528, 1814.2470874587032, 1815.4190658989128, 1865.850731941455, 105678.41482377771, 108318.45840770745, 112472.0, 113661.0, 114660.99999999917, 11438.370889601152, 11596.710082248012, 11640.06879449642, 11698.590549330733, 11915.16593838423, 11850.585229516926, 14382.993190476565, 14427.422903083969, 14484.927575362055, 14500.782488262685, 9066.365354425126, 9100.08999100098, 9198.264138868875, 9217.815643687223, 9353.812923741487, 9517.23862091031, 9519.52402379892, 9550.522473876417, 9597.952010239904, 9612.51937403127, 4693.084848454519, 4765.0946320199055, 4780.330753694486, 4820.156472617278, 4829.27560865873, 1954.1108795498014, 1993.5479360386805, 2005.2079428625611, 2025.929092481756, 2039.9796002039789, 807.9254591393433, 888.5512816027865, 1005.2309982863115, 1050.8476270940823, 1059.904608585231, 16015.0, 19325.51686207856, 20715.171393144406, 20931.790682093288, 20983.37049888506, 1012.4785735346303, 1017.2472370445817, 1022.2895087913829, 1064.1752641702742, 1074.1997212076897, 9236.503868783584, 10969.890301097046, 11272.035914434451, 11374.545018199346, 11390.886091139148, 583501.0, 645543.0, 658246.0, 675543.0, 676347.0, 130384.348078259, 130812.3459382697, 133390.0, 134781.0, 138338.0, 1057.3338796558273, 1069.6897899609182, 1069.8127827629978, 1090.6673464593216, 1094.5020015892749, 18420.0, 18630.16164272638, 18661.066946652343, 18825.90587047111, 19293.710594341377, 54514.0, 55813.0, 56307.0, 57647.71176144092, 58076.0, 80621.0, 83778.0, 84049.0, 84546.15453845629, 85180.0, 8031.867571646945, 8234.876476852733, 8238.134995825592, 8247.422680412314, 8785.989611194795, 12744.0, 13452.730945381234, 13529.932350338579, 13861.168329900238, 13877.861221387657, 8765.430247033923, 8948.284137268873, 11666.416679166177, 11919.940400297943, 12094.576689815814, 11807.704807379885, 11814.468348924147, 11838.585649502225, 11946.940265298617, 12102.152849300464, 9710.368826026286, 11289.20975531705, 12059.819102713642, 12073.698157546132, 12312.13815032939, 8399.580020998803, 8432.915670843213, 8574.914250857411, 8625.39622226438, 8787.956060219658, 11252.887471125512, 12015.939920300343, 12070.75858482843, 12119.515219391478, 12237.265764054186], "unit": "score", "name": "jquery.html", "value": 9785.44193224619}, {"lowerIsBetter": false, "replicates": [1320.2474589483998, 1492.492552532139, 1657.3784830688496, 1953.365156324195, 2092.1003968293635, 8080.353571714263, 8812.295016398688, 8975.820483590333, 8981.056989016157, 8985.0, 8747.825043499126, 8980.775480612989, 8987.236084932772, 8991.955040224806, 8993.055729148427, 2228.5988522066023, 2489.6638953741285, 2516.006177559863, 2547.541442540342, 2556.207575651554, 2575.124457684387, 2575.433404650974, 2576.6521519594894, 2579.187555919889, 2579.6775403074616, 2304.582681650781, 2450.3996520852415, 2560.0, 2563.0772921748157, 2563.9359016024655, 2256.717910261217, 2487.4154573675173, 2512.57286261336, 2541.9872900635564, 2548.1081621432536, 2499.487605040962, 2516.735742747022, 2563.192594332779, 2568.75596818302, 2573.073693470349, 8846.115388461167, 8936.46381217129, 8936.597853096626, 8943.329250306188, 8989.685361012333, 5498.147787093007, 5612.971935140298, 5613.7193140342815, 5628.409017053192, 5657.971710141423, 3598.334308153, 3658.8536458541626, 3730.1420673245307, 3754.699624030071, 3756.1360886996144, 1020.2246292817438, 1043.1602559939247, 1045.796069766396, 1060.782539579392, 1085.3704851186294, 12630.30533320667, 12668.68328291791, 12683.365831708377, 12684.936575317064, 12696.873031269753, 4705.905881882343, 5056.469070747592, 5130.97434512825, 5136.9469258801855, 5138.511841375063, 10588.4705764713, 10591.258611897247, 10603.734906627396, 10603.946980265204, 10616.097631701392, 5720.942790572041, 5727.713614319351, 5729.684867332337, 5730.083186690193, 5731.0543760279925, 4477.059817438309, 4490.550944905483, 4631.560001799824, 4635.559621835921, 4642.442906851199, 4039.757614543078, 4084.550699423061, 4153.813078411418, 4165.021220013295, 4169.874903752892, 1126.8900133368625, 1342.758303505359, 1347.6981792160245, 1348.8111664366998, 1357.043284484436, 1261.4071386448354, 1384.5846246126323, 1421.9075760075768, 1454.985450145506, 1457.358762144653, 8458.87311690325, 8559.22966932979, 8561.871571926426, 8598.914010859937, 8694.17405346491, 1247.607003793802, 1250.443552619094, 1254.5044707340733, 1261.5710658376197, 1267.5690265309838, 6415.935840641627, 6490.870182596322, 6547.0179473079415, 6547.148870646785, 6548.246951600531, 10718.89281107179, 11035.72410689723, 11136.610218642309, 11148.0, 11158.051565616852, 10940.4529773511, 11087.944560277308, 11113.888861111285, 11141.108711303077, 11188.496517656726, 8749.606267717969, 8808.471491710518, 8838.29293656506, 8864.246539044254, 8878.023417424078, 8198.877016844872, 8250.092489826235, 8289.751307460785, 8347.040090389683, 8347.2487476125, 10000.949995249977, 10038.996100389902, 10145.847812282675, 10164.593416263267, 10267.537960791633, 10217.74455638615, 10424.218183636409, 10463.529141188512, 10625.203109766953, 10678.519466624177, 5809.651420914759, 6980.232174460907, 7792.025996750406, 7805.258500442449, 7806.687732490636, 7882.211778822072, 8371.246587807127, 8598.441101328393, 8616.396852220536, 8634.611442484978, 7596.316331530189, 7612.162662107275, 7672.73145439907, 7760.805979850549, 7811.179826118176, 7486.213947535431, 7552.546847188966, 7604.961975190088, 7608.087029556267, 7611.124720656974, 6709.798706038827, 8041.477303975223, 8076.071251806117, 8078.192180781874, 8112.22933821286, 7304.123505179413, 7331.560106393634, 7370.299821516947, 7401.777946661608, 7403.370713489198, 7445.888311675221, 7452.515586486861, 7492.475526713078, 7500.287472690085, 7506.737264195727], "unit": "score", "name": "mootools.html", "value": 5123.500653942863}, {"lowerIsBetter": false, "replicates": [332.3087977007824, 337.32871585544757, 344.02812055941956, 345.0, 348.6687646735602, 6570.113034740309, 6669.86660266795, 6702.296258892819, 6730.865382692343, 6747.966260168699, 6627.635480048595, 6629.801105966817, 6638.867222655544, 6645.534812563123, 6654.500912431563, 4693.48371679115, 4743.83396581118, 4793.161196790547, 4855.0, 4977.925331120027, 4838.129136755382, 4842.515748425147, 4860.465348811628, 4867.513248675122, 4891.16850135476, 4009.278329900617, 4791.928121078186, 4797.088553174885, 4867.464578896319, 4875.512448755132, 4644.140833945714, 4761.571458568728, 4864.440589332236, 4873.756312184377, 4874.853754387339, 4180.72487891193, 4181.268278051329, 4189.601987811153, 4206.221848957922, 4218.261804184286, 4809.879753006167, 6376.29860715321, 6434.292227854932, 6436.806895793134, 6465.3857883501, 5880.6765627890445, 5882.764689412418, 5884.882302353929, 5891.116332550109, 5901.321348044987, 6866.279040700704, 7097.21930587635, 7099.183593886717, 7105.538140020882, 7121.430285577141, 4807.062622788558, 4810.759462026885, 4822.975885120587, 4829.082474329901, 4840.394950631171, 7319.41444684424, 7468.4025277977635, 7471.066116735408, 7487.288707572827, 7508.1741008489025, 4858.82994095205, 4875.43932447773, 4879.853604391874, 4890.706557606555, 4890.902181956341, 4941.382327209099, 4943.134951383494, 4944.456109827916, 4946.183879659816, 4963.379577552806, 4553.840615578439, 5614.1859430382365, 5814.825555233265, 5827.854303642358, 5839.795607153729, 7081.327273908971, 7113.857722845618, 7119.537230080028, 7120.287971202838, 7134.036905017756, 1695.7965044194775, 1729.6713624411323, 1732.2984191402502, 1733.298014304209, 1739.6433731085351, 1061.840723891407, 1094.578587243917, 1122.6519778868576, 1123.1015187849687, 1150.4937827355936, 6445.323241059715, 6602.108715323466, 6602.570832895846, 6616.4376028037195, 6617.8014659560295, 7435.665395057235, 7436.442266830009, 7437.405007599379, 7440.0, 7444.553326800409, 6555.901661475082, 6582.17722784652, 6583.30875258091, 6589.967050164719, 6596.703148358335, 3755.5681096673684, 3867.535895692479, 3898.7855667938534, 3916.5691773904846, 3918.040080180374, 7713.190115037953, 7758.0, 7767.883481747778, 7776.961115194388, 7778.183290754502, 6485.7405703772265, 7664.271894170045, 7668.156502784689, 7672.0409948756405, 7677.769666910001, 7740.032495938008, 7756.340711039625, 7758.456908016497, 7774.922250777533, 7778.222177782177, 7090.184628767758, 7379.3358597726465, 7448.404127669665, 7450.515716478411, 7465.813354666177, 7232.276772322725, 7235.855282894207, 7294.927050729637, 7335.596542190231, 7343.632818359168, 7724.92275077242, 7746.883796742941, 7753.4960227585025, 7755.457118001686, 7765.48573028254, 4681.414823147106, 4738.526147385372, 4745.5966242869745, 4757.690750101232, 4763.571278584944, 7134.0, 7428.628568571442, 7437.181909989788, 7439.181690014202, 7444.069491313586, 6476.222853257639, 6885.4835887309655, 7179.892301615376, 7186.425085993003, 7203.459740519586, 7149.857002860018, 7152.034475345762, 7162.570245785269, 7164.498485105993, 7168.641567921479, 6973.372396484341, 6985.9301406987315, 6995.0, 7002.929970700227, 7007.754728584475, 6883.724651013903, 7105.360517553445, 7119.537230080028, 7161.713531458683, 7164.892526612, 6665.466762658879, 6761.087253220949, 6868.62222577763, 6885.2770459101075, 6982.1272340957385], "unit": "score", "name": "prototype.html", "value": 5235.447775785639}, {"lowerIsBetter": false, "replicates": [713.6182142553733, 718.4432065149507, 739.9815004624887, 760.4790718357925, 788.0346575445077, 15315.846841531582, 15513.0, 15519.767203491956, 15523.301451434685, 15526.922365388185, 14328.71342573148, 14517.128972261646, 14536.273186340693, 14552.199629020399, 14559.708805823877, 619.0744836469485, 630.552307861419, 964.1322809471496, 985.6599473181741, 986.3539381704994, 975.3416443900375, 984.807962447323, 988.3081842710096, 988.4909271725068, 989.5448093876789, 664.2361284522789, 1045.8326667733165, 1046.1473898772515, 1046.1682962045193, 1046.9895301047006, 663.8838203314425, 955.4697143085584, 1035.829088200446, 1037.092544023979, 1041.7916416716687, 770.5607803551977, 770.865098607747, 772.5712229712564, 773.4392565390103, 774.9690012399498, 15189.0, 15233.695326093417, 15278.236088195657, 15280.847191528053, 15288.464903728316, 12977.480900763958, 13467.245603202651, 13476.191428514223, 13482.0, 13725.588232353046, 9716.562754676057, 10347.63783267582, 10442.738931526697, 10496.0, 10562.524686389132, 3553.466979953002, 3572.392693242129, 3574.463830425431, 3812.5424949006297, 3827.6937844972613, 74035.62982185108, 74366.5126697463, 74886.25113748848, 77847.0, 78532.21467785306, 8882.86675699865, 8961.59672814725, 8965.820683586291, 9028.909710902939, 9052.773680657905, 20917.0, 20938.162473501194, 20941.476463088544, 20959.580808383747, 20967.37097887066, 7428.0, 7463.9626801866725, 7548.131964824115, 7645.770626881203, 7702.0, 4177.4569305990635, 4209.34755112958, 4270.0, 4369.628581570602, 4463.933041004388, 3632.0, 3656.3784156693428, 3664.230511592542, 3669.0093674707678, 3674.4855720199193, 634.996825015872, 645.5739212119978, 650.3886346834056, 656.6421300391298, 668.4485299627827, 518.7795187045491, 581.880714453536, 610.3438803286484, 617.8826023055695, 632.2665707778955, 7776.416768742367, 8364.707235246737, 8512.74461766148, 8514.04177039272, 8636.136386361313, 552.4447929830494, 597.2981746447906, 605.1467430922378, 616.6485103491057, 626.3016736338949, 3470.722342212617, 3689.317476266899, 3887.922241555153, 3914.784686842251, 3991.6806655467494, 80722.38555228863, 82474.0, 82493.0, 95568.0, 97386.5130674342, 77481.61259193668, 77680.22319776843, 78875.0, 79335.20664793394, 79582.0, 70871.64564177147, 71993.0, 72033.91949120768, 72648.63675681694, 73888.1527961816, 8525.829483410422, 8637.56812159402, 8678.78303042429, 8730.476171429735, 8869.379143459895, 49092.509074910224, 50348.49651503438, 51662.48337516727, 52633.94732105413, 52690.94618107693, 65974.01038984515, 67806.0, 70133.54108610941, 70683.9397409029, 70989.64505177441, 10963.725906852393, 11309.943450283025, 11312.60405885823, 11473.311601303949, 11523.769524609628, 9686.467244301632, 11927.0, 12119.939400302943, 12420.689482762642, 12759.74480510366, 11243.325400475998, 11548.249363791327, 11638.359890205782, 11726.765464690829, 11839.58561450345, 11691.532338706356, 11808.46118084616, 12005.39973001364, 12073.637790866289, 12081.57714479989, 11138.610148644759, 11588.710282243012, 11694.70763230926, 11861.40692965331, 11881.702957425789, 9866.210703143588, 9907.0808733211, 9943.651972180938, 9954.751131221488, 10243.692689219335, 9801.705948821547, 9812.0, 9851.408915465096, 9934.0, 9935.552900119368], "unit": "score", "name": "yui.html", "value": 7029.524403593905}], "name": "dromaeo_css", "value": 7755.0775692728475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 110.0, 111.0, 113.0, 111.0, 120.0, 109.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [153.0, 119.0, 154.0, 146.0, 153.0, 173.0, 108.0, 185.0, 179.0, 111.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 201.0, 264.0, 203.0, 186.0, 186.0, 184.0, 185.0, 186.0], "unit": "score", "name": "audio-dft", "value": 196.1}, {"lowerIsBetter": true, "replicates": [71.0, 79.0, 73.0, 123.0, 56.0, 56.0, 59.0, 59.0, 125.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.8}, {"lowerIsBetter": true, "replicates": [90.0, 96.0, 128.0, 78.0, 76.0, 89.0, 115.0, 76.0, 79.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [108.0, 84.0, 88.0, 85.0, 87.0, 85.0, 88.0, 84.0, 86.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 107.0, 149.0, 109.0, 92.0, 108.0, 133.0, 115.0], "unit": "score", "name": "imaging-darkroom", "value": 108.9}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 86.0, 87.0, 87.0, 87.0, 85.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 61.0, 58.0, 58.0, 59.0, 59.0, 67.0, 50.0, 49.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 79.0, 72.0, 70.0, 66.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 79.0, 79.0, 79.0, 80.0, 79.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [130.0, 104.0, 120.0, 98.0, 123.0, 128.0, 128.0, 127.0, 125.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 134.0, 132.0, 134.0, 121.0, 132.0, 131.0, 131.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.2}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 65.0, 65.0, 66.0, 63.0, 85.0, 96.0, 93.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.2}], "name": "kraken", "value": 1441.0}]} 09:19:25 INFO - Return code: 0 09:19:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:19:25 INFO - # TBPL SUCCESS # 09:19:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:25 INFO - 2016-03-17 09:19:25.440 screenresolution[2022:13939] starting screenresolution argv=screenresolution get 09:19:25 INFO - 2016-03-17 09:19:25.442 screenresolution[2022:13939] Display 0: 1600x1200x32@60 09:19:25 INFO - 2016-03-17 09:19:25.448 screenresolution[2023:13942] starting screenresolution argv=screenresolution list 09:19:25 INFO - Available Modes on Display 0 09:19:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:25 INFO - Intel Iris: 09:19:25 INFO - Chipset Model: Intel Iris 09:19:25 INFO - Type: GPU 09:19:25 INFO - Bus: Built-In 09:19:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:25 INFO - Vendor: Intel (0x8086) 09:19:25 INFO - Device ID: 0x0a2e 09:19:25 INFO - Revision ID: 0x0009 09:19:25 INFO - Displays: 09:19:25 INFO - Display: 09:19:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:25 INFO - Display Serial Number: 1600x1200 60 09:19:25 INFO - Main Display: Yes 09:19:25 INFO - Mirror: Off 09:19:25 INFO - Online: Yes 09:19:25 INFO - Rotation: Supported 09:19:25 INFO - Return code: 0 09:19:25 INFO - Running post-action listener: _resource_record_post_action 09:19:25 INFO - Running post-run listener: _resource_record_post_run 09:19:26 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 380928; Write bytes: 662315008; Read time: 6; Write time: 1977 09:19:26 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361820672; Write bytes: 363759104; Read time: 28203; Write time: 844 09:19:26 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 356352; Write bytes: 297708032; Read time: 5; Write time: 1131 09:19:26 INFO - Running post-run listener: _upload_blobber_files 09:19:26 INFO - Blob upload gear active. 09:19:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:26 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 09:19:26 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'] 09:19:26 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 09:19:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:28 INFO - (blobuploader) - INFO - Done attempting. 09:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:29 INFO - (blobuploader) - INFO - Done attempting. 09:19:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:29 INFO - Return code: 0 09:19:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf2c9c8627a15db51f4a7b2212cdabb04aaa3fbf03bfecce5b403104736b302b4ee0b2c69169e79fae2f55890a9e577856b6f1fe90ebef7c20b5d87b48ef1b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1515060d6f21e6c44198578cc2d520e2522dbca3e3616b9425a74fb652731e466b09acb18bf0cc852d4a421cd493ff044bf2f0c5ff5031478a7181c18ed6aa55"} 09:19:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:29 INFO - Contents: 09:19:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf2c9c8627a15db51f4a7b2212cdabb04aaa3fbf03bfecce5b403104736b302b4ee0b2c69169e79fae2f55890a9e577856b6f1fe90ebef7c20b5d87b48ef1b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1515060d6f21e6c44198578cc2d520e2522dbca3e3616b9425a74fb652731e466b09acb18bf0cc852d4a421cd493ff044bf2f0c5ff5031478a7181c18ed6aa55"} 09:19:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:29 INFO - Copying logs to upload dir... 09:19:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.282732 ========= master_lag: 4.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-17 09:19:33.642300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:19:33.646234) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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/bf2c9c8627a15db51f4a7b2212cdabb04aaa3fbf03bfecce5b403104736b302b4ee0b2c69169e79fae2f55890a9e577856b6f1fe90ebef7c20b5d87b48ef1b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1515060d6f21e6c44198578cc2d520e2522dbca3e3616b9425a74fb652731e466b09acb18bf0cc852d4a421cd493ff044bf2f0c5ff5031478a7181c18ed6aa55"} build_url:https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/Z_mP95A6TP6orScXQfLccw/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/bf2c9c8627a15db51f4a7b2212cdabb04aaa3fbf03bfecce5b403104736b302b4ee0b2c69169e79fae2f55890a9e577856b6f1fe90ebef7c20b5d87b48ef1b94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1515060d6f21e6c44198578cc2d520e2522dbca3e3616b9425a74fb652731e466b09acb18bf0cc852d4a421cd493ff044bf2f0c5ff5031478a7181c18ed6aa55"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:19:34.073214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:19:34.073536) ========= 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.FmGJZUDChk/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.Z2gwHMa1q3/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005313 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:19:34.109833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:19:34.110153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:19:34.111642) ========= ========= Total master_lag: 76.28 =========