builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0170 starttime: 1457688233.51 results: success (0) buildid: 20160310231414 builduid: eed3c7d5bf0f4b94a2944af6ee211d63 revision: 767e0126510e0f65798a53a29c6b7e1469a03139 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.513312) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.516086) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.516429) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005771 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.541606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.541982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.562681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.563065) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.611767) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.615173) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.615615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.615950) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-11 01:23:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-03-11 01:23:53 (23.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.780584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.783978) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.026529 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:53.832729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 01:23:53.836174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 767e0126510e0f65798a53a29c6b7e1469a03139 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 767e0126510e0f65798a53a29c6b7e1469a03139 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-11 01:23:53,892 truncating revision to first 12 chars 2016-03-11 01:23:53,892 Setting DEBUG logging. 2016-03-11 01:23:53,892 attempt 1/10 2016-03-11 01:23:53,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/767e0126510e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 01:23:56,130 unpacking tar archive at: mozilla-central-767e0126510e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.486069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 01:23:56.343189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:56.344034) ========= echo 767e0126510e0f65798a53a29c6b7e1469a03139 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'767e0126510e0f65798a53a29c6b7e1469a03139'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 767e0126510e0f65798a53a29c6b7e1469a03139 program finished with exit code 0 elapsedTime=0.006246 script_repo_revision: '767e0126510e0f65798a53a29c6b7e1469a03139' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:56.399544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:56.400221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 01:23:56.417768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-11 01:23:56.420753) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:23:56 INFO - MultiFileLogger online at 20160311 01:23:56 in /builds/slave/test 01:23:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:23:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:56 INFO - {'append_to_log': False, 01:23:56 INFO - 'base_work_dir': '/builds/slave/test', 01:23:56 INFO - 'blob_upload_branch': 'Firefox', 01:23:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:56 INFO - 'branch': 'Firefox', 01:23:56 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:56 INFO - 'config_files': ('talos/mac_config.py',), 01:23:56 INFO - 'default_actions': ('clobber', 01:23:56 INFO - 'read-buildbot-config', 01:23:56 INFO - 'download-and-extract', 01:23:56 INFO - 'populate-webroot', 01:23:56 INFO - 'create-virtualenv', 01:23:56 INFO - 'install', 01:23:56 INFO - 'run-tests'), 01:23:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:56 INFO - 'download_minidump_stackwalk': True, 01:23:56 INFO - 'download_symbols': 'ondemand', 01:23:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:56 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:56 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:56 INFO - 'installer_path': 'installer.exe', 01:23:56 INFO - 'log_level': 'info', 01:23:56 INFO - 'log_name': 'talos', 01:23:56 INFO - 'log_to_console': True, 01:23:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:23:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:23:56 INFO - 'opt_config_files': (), 01:23:56 INFO - 'pip_index': False, 01:23:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:23:56 INFO - 'cmd': ('bash', 01:23:56 INFO - '-c', 01:23:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:23:56 INFO - 'enabled': True, 01:23:56 INFO - 'halt_on_failure': False, 01:23:56 INFO - 'name': 'check_screen_resolution'},), 01:23:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:23:56 INFO - 'cmd': ('bash', 01:23:56 INFO - '-c', 01:23:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:23:56 INFO - 'enabled': True, 01:23:56 INFO - 'halt_on_failure': False, 01:23:56 INFO - 'name': 'check_screen_resolution'},), 01:23:56 INFO - 'run_cmd_checks_enabled': True, 01:23:56 INFO - 'sps_profile': False, 01:23:56 INFO - 'sps_profile_interval': 0, 01:23:56 INFO - 'suite': 'dromaeojs', 01:23:56 INFO - 'system_bits': '32', 01:23:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:56 INFO - 'title': 't-yosemite-r7-0170', 01:23:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:56 INFO - 'use_talos_json': True, 01:23:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:56 INFO - 'work_dir': 'build'} 01:23:56 INFO - ##### 01:23:56 INFO - ##### Running clobber step. 01:23:56 INFO - ##### 01:23:56 INFO - Running pre-action listener: _resource_record_pre_action 01:23:56 INFO - Running main action method: clobber 01:23:56 INFO - rmtree: /builds/slave/test/build 01:23:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:58 INFO - Running post-action listener: _resource_record_post_action 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running read-buildbot-config step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: read_buildbot_config 01:23:58 INFO - Using buildbot properties: 01:23:58 INFO - { 01:23:58 INFO - "project": "", 01:23:58 INFO - "product": "firefox", 01:23:58 INFO - "script_repo_revision": "production", 01:23:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 01:23:58 INFO - "repository": "", 01:23:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 01:23:58 INFO - "buildid": "20160310231414", 01:23:58 INFO - "pgo_build": "False", 01:23:58 INFO - "basedir": "/builds/slave/test", 01:23:58 INFO - "buildnumber": 161, 01:23:58 INFO - "slavename": "t-yosemite-r7-0170", 01:23:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:23:58 INFO - "platform": "yosemite_r7", 01:23:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 01:23:58 INFO - "branch": "mozilla-central", 01:23:58 INFO - "repo_path": "mozilla-central", 01:23:58 INFO - "revision": "767e0126510e0f65798a53a29c6b7e1469a03139", 01:23:58 INFO - "stage_platform": "macosx64", 01:23:58 INFO - "builduid": "eed3c7d5bf0f4b94a2944af6ee211d63", 01:23:58 INFO - "slavebuilddir": "test" 01:23:58 INFO - } 01:23:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:23:58 INFO - Running post-action listener: _resource_record_post_action 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running download-and-extract step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: download_and_extract 01:23:58 INFO - mkdir: /builds/slave/test/build/tests 01:23: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')]} 01:23:58 INFO - https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 01:23:59 INFO - Downloaded 1199 bytes. 01:23:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:23:59 INFO - Using the following test package requirements: 01:23:59 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:23:59 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:23:59 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:23:59 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'jsshell-mac.zip'], 01:23:59 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:23:59 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:23:59 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:23:59 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:23:59 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:23:59 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:23:59 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:23:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:59 INFO - https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:23:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:23:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:23:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:24:01 INFO - Downloaded 17867493 bytes. 01:24:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:24:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:24:04 INFO - Return code: 0 01:24:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:04 INFO - https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:24:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:24:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:24:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:24:05 INFO - Downloaded 17867493 bytes. 01:24:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:24:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:24:08 INFO - Return code: 0 01:24: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')]} 01:24:08 INFO - https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:24:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:24:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:24:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:24:09 INFO - Downloaded 10845161 bytes. 01:24:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:24:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:24:10 INFO - Return code: 0 01:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:10 INFO - https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:24:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:24:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:24:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:24:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 01:24:13 INFO - Downloaded 111007471 bytes. 01:24:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:24:13 INFO - mkdir: /builds/slave/test/properties 01:24:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:13 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:13 INFO - Contents: 01:24:13 INFO - build_url:https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:24:14 INFO - Running post-action listener: _resource_record_post_action 01:24:14 INFO - Running post-action listener: set_extra_try_arguments 01:24:14 INFO - ##### 01:24:14 INFO - ##### Running populate-webroot step. 01:24:14 INFO - ##### 01:24:14 INFO - Running pre-action listener: _resource_record_pre_action 01:24:14 INFO - Running main action method: populate_webroot 01:24:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:14 INFO - '--tppagecycles', 01:24:14 INFO - '7'], 01:24:14 INFO - 'tests': ['tsvgm']}}, 01:24:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:24:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:24:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'tests': ['damp', 'tps']}, 01:24:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['damp', 'tps']}, 01:24:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:24:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:14 INFO - 'other': {'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'other_l64': {'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'other_nol64': {'tests': ['a11yr', 01:24:14 INFO - 'ts_paint', 01:24:14 INFO - 'tpaint', 01:24:14 INFO - 'sessionrestore', 01:24:14 INFO - 'sessionrestore_no_auto_restore', 01:24:14 INFO - 'tabpaint']}, 01:24:14 INFO - 'svgr': {'tests': ['tsvgx', 01:24:14 INFO - 'tsvgr_opacity', 01:24:14 INFO - 'tart', 01:24:14 INFO - 'tscrollx', 01:24:14 INFO - 'cart']}, 01:24:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['tsvgx', 01:24:14 INFO - 'tsvgr_opacity', 01:24:14 INFO - 'tart', 01:24:14 INFO - 'tscrollx', 01:24:14 INFO - 'cart']}, 01:24:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'tests': ['tp5o']}, 01:24:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'talos_options': ['--e10s'], 01:24:14 INFO - 'tests': ['tp5o']}, 01:24:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'talos_options': ['--xperf_path', 01:24:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:14 INFO - 'tests': ['tp5n']}, 01:24:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:14 INFO - 'talos_options': ['--e10s', 01:24:14 INFO - '--xperf_path', 01:24:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:14 INFO - 'tests': ['tp5n']}}, 01:24:14 INFO - 'talos.zip': {'path': '', 01:24:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:14 INFO - Running post-action listener: _resource_record_post_action 01:24:14 INFO - ##### 01:24:14 INFO - ##### Running create-virtualenv step. 01:24:14 INFO - ##### 01:24:14 INFO - Running pre-action listener: _resource_record_pre_action 01:24:14 INFO - Running main action method: create_virtualenv 01:24:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:24:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:14 INFO - Using real prefix '/tools/python27' 01:24:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:18 INFO - Installing pip.................done. 01:24:18 INFO - Return code: 0 01:24:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:18 INFO - 'HOME': '/Users/cltbld', 01:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:18 INFO - 'LOGNAME': 'cltbld', 01:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:18 INFO - 'MOZ_NO_REMOTE': '1', 01:24:18 INFO - 'NO_EM_RESTART': '1', 01:24:18 INFO - 'PAGER': '/bin/cat', 01:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:18 INFO - 'PWD': '/builds/slave/test', 01:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:18 INFO - 'SHELL': '/bin/bash', 01:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:18 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:18 INFO - 'USER': 'cltbld', 01:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:18 INFO - 'XPC_FLAGS': '0x0', 01:24:18 INFO - 'XPC_SERVICE_NAME': '0', 01:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:24:18 INFO - Cleaning up... 01:24:18 INFO - Return code: 0 01:24:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:18 INFO - 'HOME': '/Users/cltbld', 01:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:18 INFO - 'LOGNAME': 'cltbld', 01:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:18 INFO - 'MOZ_NO_REMOTE': '1', 01:24:18 INFO - 'NO_EM_RESTART': '1', 01:24:18 INFO - 'PAGER': '/bin/cat', 01:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:18 INFO - 'PWD': '/builds/slave/test', 01:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:18 INFO - 'SHELL': '/bin/bash', 01:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:18 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:18 INFO - 'USER': 'cltbld', 01:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:18 INFO - 'XPC_FLAGS': '0x0', 01:24:18 INFO - 'XPC_SERVICE_NAME': '0', 01:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:18 INFO - Downloading/unpacking psutil>=0.7.1 01:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:21 INFO - Installing collected packages: psutil 01:24:21 INFO - Running setup.py install for psutil 01:24:21 INFO - building 'psutil._psutil_osx' extension 01:24:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:24:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:24:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:24:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:24:22 INFO - building 'psutil._psutil_posix' extension 01:24:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:24:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:24:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:24:22 INFO - ^ 01:24:22 INFO - 1 warning generated. 01:24:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:22 INFO - Successfully installed psutil 01:24:22 INFO - Cleaning up... 01:24:22 INFO - Return code: 0 01:24:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:22 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 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:22 INFO - 'HOME': '/Users/cltbld', 01:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:22 INFO - 'LOGNAME': 'cltbld', 01:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:22 INFO - 'MOZ_NO_REMOTE': '1', 01:24:22 INFO - 'NO_EM_RESTART': '1', 01:24:22 INFO - 'PAGER': '/bin/cat', 01:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:22 INFO - 'PWD': '/builds/slave/test', 01:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:22 INFO - 'SHELL': '/bin/bash', 01:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:22 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:22 INFO - 'USER': 'cltbld', 01:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:22 INFO - 'XPC_FLAGS': '0x0', 01:24:22 INFO - 'XPC_SERVICE_NAME': '0', 01:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:24:25 INFO - Installing collected packages: mozsystemmonitor 01:24:25 INFO - Running setup.py install for mozsystemmonitor 01:24:25 INFO - Successfully installed mozsystemmonitor 01:24:25 INFO - Cleaning up... 01:24:25 INFO - Return code: 0 01:24:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:25 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 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:25 INFO - 'HOME': '/Users/cltbld', 01:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:25 INFO - 'LOGNAME': 'cltbld', 01:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:25 INFO - 'MOZ_NO_REMOTE': '1', 01:24:25 INFO - 'NO_EM_RESTART': '1', 01:24:25 INFO - 'PAGER': '/bin/cat', 01:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:25 INFO - 'PWD': '/builds/slave/test', 01:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:25 INFO - 'SHELL': '/bin/bash', 01:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:25 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:25 INFO - 'USER': 'cltbld', 01:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:25 INFO - 'XPC_FLAGS': '0x0', 01:24:25 INFO - 'XPC_SERVICE_NAME': '0', 01:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:28 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:29 INFO - Downloading docopt-0.6.1.tar.gz 01:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:29 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:29 INFO - Running setup.py install for blobuploader 01:24:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:29 INFO - Running setup.py install for requests 01:24:30 INFO - Running setup.py install for docopt 01:24:30 INFO - Successfully installed blobuploader requests docopt 01:24:30 INFO - Cleaning up... 01:24:30 INFO - Return code: 0 01:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:30 INFO - 'HOME': '/Users/cltbld', 01:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:30 INFO - 'LOGNAME': 'cltbld', 01:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:30 INFO - 'MOZ_NO_REMOTE': '1', 01:24:30 INFO - 'NO_EM_RESTART': '1', 01:24:30 INFO - 'PAGER': '/bin/cat', 01:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:30 INFO - 'PWD': '/builds/slave/test', 01:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:30 INFO - 'SHELL': '/bin/bash', 01:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:30 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:30 INFO - 'USER': 'cltbld', 01:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:30 INFO - 'XPC_FLAGS': '0x0', 01:24:30 INFO - 'XPC_SERVICE_NAME': '0', 01:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:30 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-zu0xKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:30 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-lfKF0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:30 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-8pBb5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cPYiDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-9fkZRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-tqlCTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Nfm2cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-HIQOV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-1SXzZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-BZxean-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-qZWpzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:31 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-fHrb8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:32 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-_0NQkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:32 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-f94ezf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:32 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-kNwOn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:32 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-vIZR8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:32 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-dTAhFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:32 INFO - Running setup.py install for manifestparser 01:24:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:32 INFO - Running setup.py install for mozcrash 01:24:32 INFO - Running setup.py install for mozdebug 01:24:32 INFO - Running setup.py install for mozdevice 01:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozfile 01:24:33 INFO - Running setup.py install for mozhttpd 01:24:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozinfo 01:24:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozInstall 01:24:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozleak 01:24:33 INFO - Running setup.py install for mozlog 01:24:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for moznetwork 01:24:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for mozprocess 01:24:34 INFO - Running setup.py install for mozprofile 01:24:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for mozrunner 01:24:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for mozscreenshot 01:24:34 INFO - Running setup.py install for moztest 01:24:34 INFO - Running setup.py install for mozversion 01:24:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:35 INFO - Cleaning up... 01:24:35 INFO - Return code: 0 01:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:35 INFO - 'HOME': '/Users/cltbld', 01:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:35 INFO - 'LOGNAME': 'cltbld', 01:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:35 INFO - 'MOZ_NO_REMOTE': '1', 01:24:35 INFO - 'NO_EM_RESTART': '1', 01:24:35 INFO - 'PAGER': '/bin/cat', 01:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:35 INFO - 'PWD': '/builds/slave/test', 01:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:35 INFO - 'SHELL': '/bin/bash', 01:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:35 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:35 INFO - 'USER': 'cltbld', 01:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:35 INFO - 'XPC_FLAGS': '0x0', 01:24:35 INFO - 'XPC_SERVICE_NAME': '0', 01:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-wojMfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-SlRzXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Ry8wwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-LB4W2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-5NR7wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-YxY0Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:35 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-1_kUL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-wprwec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-EwJR6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-M3G21L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-QSaBdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-w4IT_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-H2Vhm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-SCEETF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-wekvxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:36 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-VCO63k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:37 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-FlCKJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:24:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:39 INFO - Downloading blessings-1.6.tar.gz 01:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:39 INFO - Installing collected packages: blessings 01:24:39 INFO - Running setup.py install for blessings 01:24:39 INFO - Successfully installed blessings 01:24:39 INFO - Cleaning up... 01:24:39 INFO - Return code: 0 01:24:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:40 INFO - Reading from file tmpfile_stdout 01:24:40 INFO - Current package versions: 01:24:40 INFO - blessings == 1.6 01:24:40 INFO - blobuploader == 1.2.4 01:24:40 INFO - docopt == 0.6.1 01:24:40 INFO - manifestparser == 1.1 01:24:40 INFO - mozInstall == 1.12 01:24:40 INFO - mozcrash == 0.17 01:24:40 INFO - mozdebug == 0.1 01:24:40 INFO - mozdevice == 0.48 01:24:40 INFO - mozfile == 1.2 01:24:40 INFO - mozhttpd == 0.7 01:24:40 INFO - mozinfo == 0.9 01:24:40 INFO - mozleak == 0.1 01:24:40 INFO - mozlog == 3.1 01:24:40 INFO - moznetwork == 0.27 01:24:40 INFO - mozprocess == 0.22 01:24:40 INFO - mozprofile == 0.28 01:24:40 INFO - mozrunner == 6.11 01:24:40 INFO - mozscreenshot == 0.1 01:24:40 INFO - mozsystemmonitor == 0.0 01:24:40 INFO - moztest == 0.7 01:24:40 INFO - mozversion == 1.4 01:24:40 INFO - psutil == 3.1.1 01:24:40 INFO - requests == 1.2.3 01:24:40 INFO - wsgiref == 0.1.2 01:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:40 INFO - 'HOME': '/Users/cltbld', 01:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:40 INFO - 'LOGNAME': 'cltbld', 01:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:40 INFO - 'MOZ_NO_REMOTE': '1', 01:24:40 INFO - 'NO_EM_RESTART': '1', 01:24:40 INFO - 'PAGER': '/bin/cat', 01:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:40 INFO - 'PWD': '/builds/slave/test', 01:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:40 INFO - 'SHELL': '/bin/bash', 01:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:40 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:40 INFO - 'USER': 'cltbld', 01:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:40 INFO - 'XPC_FLAGS': '0x0', 01:24:40 INFO - 'XPC_SERVICE_NAME': '0', 01:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:24:40 INFO - Cleaning up... 01:24:40 INFO - Return code: 0 01:24:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:40 INFO - 'HOME': '/Users/cltbld', 01:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:40 INFO - 'LOGNAME': 'cltbld', 01:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:40 INFO - 'MOZ_NO_REMOTE': '1', 01:24:40 INFO - 'NO_EM_RESTART': '1', 01:24:40 INFO - 'PAGER': '/bin/cat', 01:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:40 INFO - 'PWD': '/builds/slave/test', 01:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:40 INFO - 'SHELL': '/bin/bash', 01:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:40 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:40 INFO - 'USER': 'cltbld', 01:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:40 INFO - 'XPC_FLAGS': '0x0', 01:24:40 INFO - 'XPC_SERVICE_NAME': '0', 01:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:40 INFO - Downloading/unpacking jsonschema 01:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:43 INFO - Downloading/unpacking functools32 (from jsonschema) 01:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:43 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:43 INFO - warning: no files found matching '*.txt' 01:24:43 INFO - no previously-included directories found matching 'build' 01:24:43 INFO - no previously-included directories found matching 'dist' 01:24:43 INFO - no previously-included directories found matching '.git*' 01:24:43 INFO - Installing collected packages: jsonschema, functools32 01:24:43 INFO - Running setup.py install for functools32 01:24:43 INFO - warning: no files found matching '*.txt' 01:24:43 INFO - no previously-included directories found matching 'build' 01:24:43 INFO - no previously-included directories found matching 'dist' 01:24:43 INFO - no previously-included directories found matching '.git*' 01:24:43 INFO - Successfully installed jsonschema functools32 01:24:43 INFO - Cleaning up... 01:24:43 INFO - Return code: 0 01:24:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:43 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 0x106bc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bcd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98aad9a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, '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.DBDevz9UVU/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.4NoCsFA6Li/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:43 INFO - 'HOME': '/Users/cltbld', 01:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:43 INFO - 'LOGNAME': 'cltbld', 01:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:43 INFO - 'MOZ_NO_REMOTE': '1', 01:24:43 INFO - 'NO_EM_RESTART': '1', 01:24:43 INFO - 'PAGER': '/bin/cat', 01:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:43 INFO - 'PWD': '/builds/slave/test', 01:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:43 INFO - 'SHELL': '/bin/bash', 01:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:24:43 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:43 INFO - 'USER': 'cltbld', 01:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:43 INFO - 'XPC_FLAGS': '0x0', 01:24:43 INFO - 'XPC_SERVICE_NAME': '0', 01:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:44 INFO - Downloading/unpacking flake8 01:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:24:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:24:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:24:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:47 INFO - no previously-included directories found matching 'docs/_build' 01:24:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:24:47 INFO - Running setup.py install for pep8 01:24:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:47 INFO - no previously-included directories found matching 'docs/_build' 01:24:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:24:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:24:47 INFO - Cleaning up... 01:24:47 INFO - Return code: 0 01:24:47 INFO - Running post-action listener: _resource_record_post_action 01:24:47 INFO - Running post-action listener: _start_resource_monitoring 01:24:47 INFO - Starting resource monitoring. 01:24:47 INFO - ##### 01:24:47 INFO - ##### Running install step. 01:24:47 INFO - ##### 01:24:47 INFO - Running pre-action listener: _resource_record_pre_action 01:24:47 INFO - Running main action method: install 01:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:48 INFO - Reading from file tmpfile_stdout 01:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:48 INFO - Reading from file tmpfile_stdout 01:24:48 INFO - Output received: 01:24:48 INFO - Usage: mozinstall [options] installer 01:24:48 INFO - Options: 01:24:48 INFO - -h, --help show this help message and exit 01:24:48 INFO - -d DEST, --destination=DEST 01:24:48 INFO - Directory to install application into. [default: 01:24:48 INFO - "/builds/slave/test"] 01:24:48 INFO - --app=APP Application being installed. [default: firefox] 01:24:48 INFO - mkdir: /builds/slave/test/build/application 01:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:25:22 INFO - Reading from file tmpfile_stdout 01:25:22 INFO - Output received: 01:25:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:25:22 INFO - Running post-action listener: _resource_record_post_action 01:25:22 INFO - ##### 01:25:22 INFO - ##### Running run-tests step. 01:25:22 INFO - ##### 01:25:22 INFO - Running pre-action listener: _resource_record_pre_action 01:25:22 INFO - Running main action method: run_tests 01:25:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:25:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:25:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:25:22 INFO - 2016-03-11 01:25:22.061 screenresolution[1645:7324] starting screenresolution argv=screenresolution get 01:25:22 INFO - 2016-03-11 01:25:22.064 screenresolution[1645:7324] Display 0: 1600x1200x32@60 01:25:22 INFO - 2016-03-11 01:25:22.070 screenresolution[1646:7327] starting screenresolution argv=screenresolution list 01:25:22 INFO - Available Modes on Display 0 01:25:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:25:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:25:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:25:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:25:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:25:22 INFO - Intel Iris: 01:25:22 INFO - Chipset Model: Intel Iris 01:25:22 INFO - Type: GPU 01:25:22 INFO - Bus: Built-In 01:25:22 INFO - VRAM (Dynamic, Max): 1536 MB 01:25:22 INFO - Vendor: Intel (0x8086) 01:25:22 INFO - Device ID: 0x0a2e 01:25:22 INFO - Revision ID: 0x0009 01:25:22 INFO - Displays: 01:25:22 INFO - Display: 01:25:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:25:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:25:22 INFO - Display Serial Number: 1600x1200 60 01:25:22 INFO - Main Display: Yes 01:25:22 INFO - Mirror: Off 01:25:22 INFO - Online: Yes 01:25:22 INFO - Rotation: Supported 01:25:22 INFO - Return code: 0 01:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:22 INFO - Python 2.7.3 01:25:22 INFO - Return code: 0 01:25:22 INFO - grabbing minidump binary from tooltool 01:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:22 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 0x106a69d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a60b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:25:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:25:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:22 INFO - Return code: 0 01:25:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:25:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:25:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:25:23 INFO - Return code: 0 01:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DBDevz9UVU/Render', 01:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:23 INFO - 'HOME': '/Users/cltbld', 01:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:23 INFO - 'LOGNAME': 'cltbld', 01:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:23 INFO - 'MOZ_NO_REMOTE': '1', 01:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:23 INFO - 'NO_EM_RESTART': '1', 01:25:23 INFO - 'PAGER': '/bin/cat', 01:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:23 INFO - 'PWD': '/builds/slave/test', 01:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:23 INFO - 'SHELL': '/bin/bash', 01:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4NoCsFA6Li/Listeners', 01:25:23 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 01:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:23 INFO - 'USER': 'cltbld', 01:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:23 INFO - 'XPC_FLAGS': '0x0', 01:25:23 INFO - 'XPC_SERVICE_NAME': '0', 01:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:25:23 INFO - mozversion application_buildid: 20160310231414 01:25:23 INFO - mozversion application_changeset: 767e0126510e0f65798a53a29c6b7e1469a03139 01:25:23 INFO - mozversion application_display_name: Nightly 01:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:23 INFO - mozversion application_name: Firefox 01:25:23 INFO - mozversion application_remotingname: firefox 01:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:25:23 INFO - mozversion application_vendor: Mozilla 01:25:23 INFO - mozversion application_version: 48.0a1 01:25:23 INFO - mozversion platform_buildid: 20160310231414 01:25:23 INFO - mozversion platform_changeset: 767e0126510e0f65798a53a29c6b7e1469a03139 01:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:25:23 INFO - mozversion platform_version: 48.0a1 01:25:23 INFO - using testdate: 1457688323 01:25:23 INFO - actual date: 1457688323 01:25:23 INFO - starting webserver on 'localhost:49271' 01:25:23 INFO - SUITE-START | Running 2 tests 01:25:23 INFO - TEST-START | dromaeo_css 01:25:23 INFO - operating with platform_type : mac_ 01:25:23 INFO - Initialising browser for dromaeo_css test... 01:25:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpQppDU9/profile http://localhost:49271/getInfo.html) 01:25:26 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 01:25:26 INFO - PROCESS | 1664 | colorDepth:24 01:25:26 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 01:25:26 INFO - PROCESS | 1664 | __metrics 01:25:26 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:25:26 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:25:26 INFO - TEST-INFO | 1664: exit 0 01:25:26 INFO - Browser initialized. 01:25:26 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:26 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpQppDU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:38 INFO - PROCESS | 1667 | RSS: Main: 243089408 01:25:38 INFO - PROCESS | 1667 | 01:26:29 INFO - PROCESS | 1667 | 1457688389939 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:28:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 01:28:41 INFO - PROCESS | 1667 | RSS: Main: 360996864 01:28:41 INFO - PROCESS | 1667 | 01:31:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 01:31:44 INFO - PROCESS | 1667 | RSS: Main: 370401280 01:31:44 INFO - PROCESS | 1667 | 01:34:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 01:34:47 INFO - PROCESS | 1667 | RSS: Main: 372899840 01:34:47 INFO - PROCESS | 1667 | 01:37:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 01:37:50 INFO - PROCESS | 1667 | RSS: Main: 331288576 01:37:50 INFO - PROCESS | 1667 | 01:40:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 01:40:53 INFO - PROCESS | 1667 | RSS: Main: 333631488 01:40:53 INFO - PROCESS | 1667 | 01:43:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 01:43:56 INFO - PROCESS | 1667 | RSS: Main: 385470464 01:43:56 INFO - PROCESS | 1667 | 01:43:56 INFO - PROCESS | 1667 | __start_tp_report 01:43:56 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 01:43:56 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 01:43:56 INFO - PROCESS | 1667 | |i|pagename|runs| 01:43:56 INFO - PROCESS | 1667 | |0;dojo.html;2756.779457643389;3265.905921516292;3434.141464633842;3436.3127374525084;3502.4045912194943;5489.560835133189;5562.638428502145;5592.328920529537;5595.356533998592;5610.971945140273;5576.996140694673;5621.437856214377;5624.831255062355;5634;5637.210790489335;4320.848770293041;4369.868903932887;4950.960298337344;5127.564157046656;5157.7936882524655;5111.923321150167;5156.432792392852;5178.378594568657;5181.404138524062;5198.0383629028565;4483.834203107183;4996.675216110941;5066.898662026757;5153.201253805666;5162.354705661793;5130.486951304877;5170.508801663836;5180.119379705459;5199.896002079975;5242.842714718565;4947.604191664658;4981.2030075187795;5073.77168027436;5109.565686916617;5120.974395128038;5495.175723641446;5499.1476321170285;5544.500994910437;5556.138798486241;5615.578831587606;6141.692915354259;6155.045967874987;6173.753049878;6174.475169610589;6189.6286222826775;6041.033434650435;6054.589585391162;6191.823962049801;6214.65819379934;6250.187475628185;5701.173329867146;5701.800436984686;5711.742971566248;5747.798827041033;5764.279465066867;6246;6314.305426403092;6319.905201421982;6324.241091069009;6327.683615819191;5066.138756411419;5893.145493903446;5936.257967754031;6064.9090263646085;6096.420840020191;6155.114855734774;6197.96901015501;6205.844853878689;6223.96888015557;6226;6103;6152.938470615326;6164.229471316085;6169.84575385619;6177.81466556004;5985.670788106696;6103.908441373383;6171.753129874754;6185.8144255672405;6199.5660303779205;4869.878253043702;4872.317875497433;4881.658283920092;4886.218205087169;4916.213405855046;4091.8363265469643;4342.08816148606;4356.978215108904;4365.454318210223;4389.100234451929;5042.218456139304;5580.162975553618;5608.915866262009;5623.465770751772;5647.604667673223;6160.722767475474;6164.815055548341;6168.074788781629;6172.69136543171;6177.598456100339;5566.415526369754;5682.090865461506;5719.084946408555;5720.313562372542;5720.542356611461;5324;5333.599980001438;5339.5728341732565;5344.43883392246;5345.33183352081;6224.253089629274;6238.344973777779;6294.874102517924;6306.369363063749;6307.684615769193;6130.887362651087;6307.716152773044;6316.431521163117;6319.873602527831;6322.810315690536;6225.595336303126;6267.373262673696;6281.71732272058;6289.7484100635465;6300.810975670737;5814.418558144152;5938.287405511366;5942.851428714317;5947.9405205949115;5991.970040149946;6132.08018797184;6187.16473276102;6208.844778880564;6215.782447614311;6227.532935029982;5944.910826337695;6005.249343832021;6007.038873780174;6011.639301641915;6065.969670151621;5768.769249229984;5913.319968203539;5961.135635332766;5986.491148252448;6000.5799594028;4470.619997300266;5787.56593255516;5791.420857914175;5803.622764520293;5843.7370318336625;5898.646081234968;5944.8811023780145;5963.642181469126;5972.283326000907;6027.60820546663;5664.773409063756;5811.970940145272;5813.389594092729;5816.883662326814;5833.591648584728 01:43:56 INFO - PROCESS | 1667 | |1;ext.html;495.4475759528127;575.516566084489;577.7607032914399;628.7453581299574;632.4782054804786;26496.735032649667;38645.42031869524;38952.61047389525;39027.12160979881;39091.60908390922;41906;42316.788416057876;42356.57643423565;42423;42425.78787106068;9508.239340852733;9756.756081097958;9762.609495620167;9765.414075155513;9838.311318207729;9493.762655933588;9651.986541413156;9659.855102173473;9672.419654820698;9820.165285950703;9773.21814254858;9841.311108222428;9852.458114803683;9856.457894815781;9872.506374681274;9771.316007879452;9833.26250531213;9840.803183936352;9845.753856153618;9875.851862222073;9679.612815487371;9756.268279879037;9773.853392199122;9784.608615655365;9806.558704858298;40410.39384409236;40848.795756021325;40878.59121408778;40882.79558602218;40941;2918.8394638294885;3251.561039259693;3264.7061764441078;3476.513288139637;3503.7147102526;29777;30799.076027719206;31595.21011974719;31609;31642.525362119588;2707.891684332624;2722.278596171996;2831.3327558470487;2878.29481776966;2880.9711902880913;392127;396141.9999999971;397774;398210;398329;70212;70911.2908870915;71660.92508612375;71860.28139718641;72173.27826721771;78388.60805695935;78973.21026789774;79031.20968790354;79143;79146.81279780807;16939.32242710278;17107.657846842994;17112.657746844994;17152.48542543726;17164.05597692139;12885.806712899313;12917.741645167232;12961.740765184644;12974.675633109058;13020.47918083266;22133.446663833533;23245.88377058104;23282.417939551648;23357.649635255486;23362.415939601648;10076.29465937392;10077.59689612422;10360.637377691895;10360.740981475372;10363.689089327332;803.6423791412765;857.5797859049021;923.4136323434667;958.3387462650749;1017.1252722658655;26292.342691432867;26645.60031599489;27082.593761093598;27566.310842228704;27958.301042473693;1105.5025238642643;1107.7507560798756;1127.2334812327697;1159.6579009192308;1206.843110395643;14283.357248923823;14330.426782928565;14337.713245735027;14413.639659008399;14551.05418147817;512011;514760;517985;518055;518642;57726.134107988415;58096.419035809944;58183.70908145432;58205.70897145487;58233;1351.4053816320788;1466.4647403697575;1493.7460631692638;1505.427937383809;1515.7953676253785;27426.862865685544;27448.588271175548;28078.57882131729;28119.718802812527;28333.291667708472;43710.90722731957;43833.78083109692;44245.336319954586;44325.11349773051;44427.77786111178;285544;286757;287793;288385;288906;28541.85832566674;32696;32831.671683283814;33365.16587085342;33412.49881251735;39358.803205983786;40129.79610611686;40261.39607905825;40356.59643403528;41453.58546414497;33847.66152338445;34734.47898281477;34763;35356.64643353534;35652.46521302235;35778.463323049655;35887.82056089703;35920.28159436744;36736.63263367332;36946.07634809151;29538.55692164662;35289.29421411609;35468.290634186655;35536.11159721028;36698.8165059173;31451.754013207923;31823.840880795447;31864.522032169072;31939.520907185946;32175;23340.066397343915;23672.61030141727;23676.408089797893;24029.918653660978;24040.038398463865 01:43:57 INFO - PROCESS | 1667 | |2;jquery.html;355.9519464872243;356.3176516970002;356.90964104660253;361.35498135827544;366.19985332049475;17311;19738.802611973875;20921.790782092176;20927.37217883466;20952.26667066651;19806.40580782575;20598.21924040254;20686.48283792906;21166.365009049754;21168.57662846746;5811.506021988125;6050.788222412217;6072.423119803611;6074.331823499434;6092.847678808043;4237.597428244312;4548.999220171557;5935.88128237435;6611.669416529178;6629.4696424286185;6267.780627678032;6412.775552855651;6439.356064393546;6532.150820393343;6546.639934803584;5489.231507588941;6163.87672246557;6305.558610897239;6401.9039714404325;6408.391202835746;5487.533559647435;5498.092814685572;5505.9724701376235;5513.558915286768;5515.09001014832;25024.624630630555;25370.365740856625;25705.228843134737;25765.871170644215;25861;2157.431790011305;2168.316980151263;2211.347652442533;2219.5006123622215;2838.929026774347;14315.49895753654;14363.281835908163;14398;14952.40190392383;15003.774943375858;1730.0398278955174;1747.4320845725063;1754.0878743053668;1774.7604073450048;1788.794288656808;93751.53124234403;95371.52314238454;96227;96719.51640241753;98709.02581948321;10292.176625869912;10299.433531155708;10721.088707459798;10743.086837618734;10853.023227909369;12716.364181790874;12790.68023299425;12813;12826.486940522462;12853.357332133355;8323;8501;8519.872201916976;8616.870746938801;8619.396642234984;8677.696280630147;8743;8758.737237882873;8824.02935677075;8857.867131993025;5206.401263854629;6166.599171053867;6264.780732674334;6271;6283.120363149163;1805.3320271499629;1843.5483306589972;1863.4968558489131;1875;1884.7644044494439;934.5420743835472;986.2898712926682;987.4914419074182;1011.5650270383805;1035.140833108518;18004.54988625295;18915.973444249128;19747.802521974885;20263.79736202619;20988.26541071055;882.9735107946772;974.3715303629261;996.8006398720285;1002.7994401119805;1035.1822060572215;11320.716982075513;11398.385884203877;11524.308541487537;11566.65300041;11585.536578536765;639152;640256;643396;653401;655469;63464.68267658632;63746;63750.72498550096;98966.5051674737;102708.48645756724;1016.3190662256306;1071.7910007548453;1071.807074726541;1080.935143891369;1104.4091411095187;17430.738538921672;17661.82338176602;17706.118945676997;17732.29070837152;17890.731639025165;41250;43058;45699.54300456953;47651.76174119107;47941.28088078751;64535.70928581496;65093.67453162704;65140.67429662821;65182;65254.02118968124;7881.054273487218;8046.476978996347;8079.313258373104;8150.347972162332;8357.373197010127;11566.94216528912;12325;12556.87443125557;13196.60410187696;13531.526396576073;11208.439578020903;11479.4260286987;11564.074874010228;11584.420778961186;11629.302241865515;9911.405315681082;10317.658704368685;11129.443527823738;11433.485493152662;11711.648650540497;11336.716582085513;11627.709307267385;11857.881421186023;11907.583234587095;11968.700782480508;6733.494987876027;6779.389854913082;7944.84110317802;8156.796080098045;8359.749207523784;11231.15766317513;11678.357690327113;11765.823512647488;11866.584669536525;12007.579734709243 01:43:57 INFO - PROCESS | 1667 | |3;mootools.html;1416.7874818777175;1562.4062856114674;1578.3370984186645;1876.3339014649798;2033.745781777278;7949.364050875924;8524.8721269181;8755.080716524768;8772.605232764517;8774.298056155509;8357.16428357164;8607.91392086079;8610.655573777058;8614.827703445928;8614.87077693835;2170.967435488461;2223.2774348336775;2234.3967128875192;2437.9390515237083;2465.5315490056923;2451.117597664839;2515.195137555983;2518.244526642009;2520.8109391795597;2521.760432758885;2380.452495925938;2400.6759087523137;2406.927792166229;2417.286900364397;2418.9879050604723;2425.7210420801657;2437.195725410619;2442.5237078769646;2451.7915977141965;2477.3682710908784;2450.4853980664084;2460.225029115823;2466.3217615155795;2469.259222233323;2482.3173627252468;8749.737507874774;8805.515696636683;8813.603387847563;8813.691520796741;8816.206541411304;5372.650777699476;5523.116301391758;5523.226748255248;5525.143602741541;5531.695756733378;3497.6502349765074;3580.2481478889463;3641.3445579795625;3646.690031347339;3660.2313514162056;950.6577632052456;999.8150342186646;1041.156663102889;1063.1016790811752;1071.833865750802;11763.176577639568;11799.882001179963;11832.349220792852;11837.053035757204;11847.111466640037;4916.385451818523;4964.329815474937;4984.42679091909;5001.44984051754;5004.149294619923;10046.296759226783;10048;10051.095401413908;10056.245781566411;10081.949590252001;5491.121420572769;5513.972430137904;5525.640833345819;5535.142052981794;5542.251796007487;4455.108978204372;4617.238155704338;4674.649401294916;5028.84913452597;5041;3901.9804900975314;3948.8420463181724;3958.5843486434087;3983.2232714620372;4002.6597739192493;1296.8703129686955;1310.8623594522628;1311.3508813137366;1321.6167311479755;1322.2529270961875;1348.7572236997435;1356.7939387897636;1364.5428781358157;1384.778435450323;1389.256747640028;8219.917800821915;8247.505149691038;8251.876221856677;8265.214804593554;8284.845940055508;509.34803451582036;525.5979175930416;529.9152135658276;532.0874699889707;533.2694208933785;5016.849494515171;6210.627362358183;6229.314775374705;6250.968745156245;6280.120783090371;10269.486525673836;10627.628033018962;10636.095931845724;10744;10755.731106722238;10009.199264058858;10552.208584356204;10600.575976960836;10607.734806629742;10620;7354.669039893218;7684.961575192088;7948.006499187602;8116.310113640288;8140.918590814016;8023.839523209386;8045.919540804517;8078.515289082674;8123.025236971365;8183.427160098736;8281.751547453587;8937.06160853101;9368.95315523418;9504.239660827256;9600.903990960001;9571.33000689945;9721.416714997124;9879.209663227068;10112.747181320527;10134.746631334276;6832.521723479309;7016.859662806817;7295.927040729524;7485.737999170003;7628.656710448154;8092.109867914407;8423.8736418955;8441.071482136836;8451.408401411842;8455.577221139041;7213.7835864922035;7360.77917662471;7509.8498030038;7628.8474230516185;7685.154632990255;7167.104111986002;7197.532160409557;7233.31283528064;7251.274872512707;7380.33576978053;7629.198934111839;7647.617619118911;7676.040494938133;7687.692492300245;7704.499207551491;6788.355106265094;6926.58440493572;6967.581945083311;6969.686364113526;6975.232724400414;7107.324804143598;7159.534630249017;7164.426845852215;7168.462365322517;7185.964070179824 01:43:57 INFO - PROCESS | 1667 | |4;prototype.html;325.12865520405313;328.22047636862453;332.19277156509673;335.2022187194477;337.45164108323956;6397.776077837277;6453.5159863010285;6462.0953066570655;6464.191976003;6495.058216558602;5798.594098413102;5904.557158213141;6417.39034791694;6446.484281257488;6460.127882735829;4563.634909207272;4641.512641172662;4683.32091846682;4779.545943135414;4806.90386192275;4721.622270218374;4722.291656251573;4749.85750427486;4752.1921273383605;4752.382190315271;4670.813167473297;4701.200795864711;4715.104130215265;4727.479977202505;4738.336632871401;4518.1415531049;4582.77086145693;4702.130105930414;4703.764811759433;4721.834735784231;4073.918521629551;4078.3474644057105;4082.6121518455698;4082.857100001486;4086.0397806515443;6115.816525504242;6234.937650623481;6291.842703932392;6304.581469169446;6305.59013664115;5612.579056570733;5613.494785469286;5620.437956204388;5626.718664066781;5632.267805185341;6897.724091036353;6899.17209934806;6916.308369163094;6918.273581273944;6919.411849992756;3737.252549490113;4305.612494875445;4468.620167285784;4499.910001799945;4520.163769702583;6606.711691220214;6943.826404339881;7343.008693826372;7345.669444874993;7356.779296621056;4582.473015603182;4593.081383723269;4595.035042641016;4597.862064138081;4599.517050709627;4649.511801260886;4651.627869770478;4652.534746525388;4653.604443622262;4664.720116792935;5522.392536820947;5524.14375771756;5524.889502209933;5534.280543529316;5537.6954267515675;6720.1599800025;6942.93057069433;6985.301469853076;6995.915633076881;7025.192102908231;1590.7852439920462;1598.1130472587593;1613.9273732682057;1614.160636469053;1621.691878543073;974.8050389922043;1007.808516381885;1028.311031608824;1033.178622994721;1061.2200032975757;6404.935950640527;6529.869402611921;6538.1827271591055;6559.311272316433;6589.308122647149;5919.822405327847;7213.531120477152;7231.566106033655;7246.239144889816;7253.782386528413;6526.053722210253;6527.934720652827;6551.312112228147;6581.243157036906;6583.979483180115;3771.2080463102507;3803.6006219347123;3806.923861522754;3811.0091376242376;3817.9427308590393;7262.818429539304;7543.547387156788;7561.2060733622175;7570;7597.544147351176;7400.074990626172;7407.8148046299275;7445.739399121005;7462.626868656545;7469.701211951569;7542.773716788505;7544.849103017909;7557.183622270718;7567.9243207567215;7570.1672815989095;6920.861582768216;7219.6751146199595;7224.385927196247;7228.951801988787;7239.420846332176;7010.298970103153;7116.964415177891;7163.534370265916;7171.067761191011;7177.605231712306;7569.545827250383;7577.507462014952;7586.24137586237;7587.317141457295;7587.544747315179;4559.772011399483;4603.355530225704;4606.262997920317;4607.40103786519;4609.539046095364;6971.26801685836;7218.27817218295;7219.60292183935;7226.783196504113;7237.299234679951;5912.822615321547;6838.316168383122;6976.860462790817;6999.720011199495;7096.7516136934955;6896;6963.40811031068;6966.164060312795;6971.302869713191;6994.405475534433;6824.7952561423235;6840.657967101724;6842.55523390978;6843.7604683835825;6855.794326170223;6696.966515167393;6986.9650651746415;6994.895076573754;7005.474589405917;7005.649717514206;5524;6512.218533775787;6605;6691.866162676622;6866.759663411756 01:43:57 INFO - PROCESS | 1667 | |5;yui.html;745.8545583611194;748.5508694783127;749.4528993834504;768.2739810878718;802.8474589827935;15039.699206015886;15233.162176080312;15358.769618455732;15370.53888383349;15370.692586148285;13980;14177.787333189985;14194.787078193835;14202.28988550571;14213.71572568548;742.6917829100917;744.8957145999565;894.5437826708361;927.1609193679731;927.3091546797646;926.1988380051241;929.0245242495387;930.1303281431883;931.6273490603745;932.822763674903;981.4847205217283;991.1624677147798;992.8361820299642;994.0804755601076;996.5017491254373;764.4152223548989;966.0436168193509;983.503330817936;984.0848011349442;991.1426615977127;733.6111860713777;738.1843063414902;738.759903031517;739.161052205745;739.7484855149221;15220.391184352613;15241.695166096726;15252.466163684328;15266;15305.1582162981;12509.56216532417;12594.24434533931;12600;12681.936590317082;12953.222806631633;9919.256055795844;10065.396076235449;10290.07389334956;10400.323978941344;10847.728806779814;3544.8759293424605;3548.822558872046;3583.2654305867236;3628.401313783249;3643.234920666663;78446;81972;82022.17977820204;82145;82489.58755206245;7916.287534121957;9785.951070244602;9803.803923921481;9847.75380615476;9916.752081197883;22615.43461413445;22744.431389215402;22749.658755118686;22769.544609107725;22775.772242277366;7403.259674032553;7407.555546667109;7507.737229196952;7687.730929417444;7787.299143077037;4010.037590978144;4043.959560404417;4054.959450405517;4082.2243773682903;4104.733192342548;3634.83643236055;3660.798656073888;3682.7294583368694;3685.244524872395;3685.963140368562;695.9095317608678;704.9083619129583;713.6467448612866;714.5498336048256;726.2374506767873;537.725759862473;575.8761866198787;592.3424998252023;609.1046162141645;617.4998251416367;7632.204958743475;7943.9602801986775;7967.681292748225;8141.674333026731;8244.83510329802;492.53455484567456;562.2943206276097;602.0908428273339;605.5609682979805;608.1182285685774;3421.5380923575;3770.698344132463;3771.4342848572387;3831.061389959422;4010.578889216649;90539.54730226439;91353;92434.61348079784;92860;93185.06814931764;76261.61869190619;77258.61370693111;77444.61277693576;77813.61093194498;78047;66261.66869165623;66558;66615.66692166508;68105.31894681089;68560;7561.924380756122;7564.924350756422;7697.807554811175;7860.331871790733;7958.243966823143;49032.75483622559;50562.49437505578;50782;50833.2041737708;51386.48613513967;65459;69602.9559556597;69741;72119.91820122808;73507;10129.949350253202;10206.540705668114;10363.015513526203;10613.991670791262;10719.732006699895;10743.24797264184;10750.8387374191;10984.670459886216;11058.778824423627;11844.28934263947;10293.9485302576;10358.896411035794;10533;10743.677689669323;10756;10316.123129534073;10408.115310198718;10436.217283703905;10621.734456638645;10644.254902156774;10159;10411.271211015459;10447.94776026115;10493.527791249564;10525.526351314056;8662.82674346497;8860.955695221483;8968.865467018131;8990.91009089927;9008.90991090107;8671.262942649946;8740.519271440131;8792.956035219782;8815.206631403205;8980.820383592421 01:43:57 INFO - PROCESS | 1667 | __end_tp_report 01:43:57 INFO - PROCESS | 1667 | __start_cc_report 01:43:57 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1037 01:43:57 INFO - PROCESS | 1667 | __end_cc_report 01:43:57 INFO - PROCESS | 1667 | __startTimestamp1457689436993__endTimestamp 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | ------- Summary: start ------- 01:43:57 INFO - PROCESS | 1667 | Number of tests: 6 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5632.21 Median:5811.97 stddev:673.95 (11.6%) stddev-sans-first:637.15 01:43:57 INFO - PROCESS | 1667 | Values: 2756.8 3265.9 3434.1 3436.3 3502.4 5489.6 5562.6 5592.3 5595.4 5611.0 5577.0 5621.4 5624.8 5634.0 5637.2 4320.8 4369.9 4951.0 5127.6 5157.8 5111.9 5156.4 5178.4 5181.4 5198.0 4483.8 4996.7 5066.9 5153.2 5162.4 5130.5 5170.5 5180.1 5199.9 5242.8 4947.6 4981.2 5073.8 5109.6 5121.0 5495.2 5499.1 5544.5 5556.1 5615.6 6141.7 6155.0 6173.8 6174.5 6189.6 6041.0 6054.6 6191.8 6214.7 6250.2 5701.2 5701.8 5711.7 5747.8 5764.3 6246.0 6314.3 6319.9 6324.2 6327.7 5066.1 5893.1 5936.3 6064.9 6096.4 6155.1 6198.0 6205.8 6224.0 6226.0 6103.0 6152.9 6164.2 6169.8 6177.8 5985.7 6103.9 6171.8 6185.8 6199.6 4869.9 4872.3 4881.7 4886.2 4916.2 4091.8 4342.1 4357.0 4365.5 4389.1 5042.2 5580.2 5608.9 5623.5 5647.6 6160.7 6164.8 6168.1 6172.7 6177.6 5566.4 5682.1 5719.1 5720.3 5720.5 5324.0 5333.6 5339.6 5344.4 5345.3 6224.3 6238.3 6294.9 6306.4 6307.7 6130.9 6307.7 6316.4 6319.9 6322.8 6225.6 6267.4 6281.7 6289.7 6300.8 5814.4 5938.3 5942.9 5947.9 5992.0 6132.1 6187.2 6208.8 6215.8 6227.5 5944.9 6005.2 6007.0 6011.6 6066.0 5768.8 5913.3 5961.1 5986.5 6000.6 4470.6 5787.6 5791.4 5803.6 5843.7 5898.6 5944.9 5963.6 5972.3 6027.6 5664.8 5812.0 5813.4 5816.9 5833.6 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:56357.09 Median:35715.46 stddev:109059.12 (305.4%) stddev-sans-first:109284.41 01:43:57 INFO - PROCESS | 1667 | Values: 495.4 575.5 577.8 628.7 632.5 26496.7 38645.4 38952.6 39027.1 39091.6 41906.0 42316.8 42356.6 42423.0 42425.8 9508.2 9756.8 9762.6 9765.4 9838.3 9493.8 9652.0 9659.9 9672.4 9820.2 9773.2 9841.3 9852.5 9856.5 9872.5 9771.3 9833.3 9840.8 9845.8 9875.9 9679.6 9756.3 9773.9 9784.6 9806.6 40410.4 40848.8 40878.6 40882.8 40941.0 2918.8 3251.6 3264.7 3476.5 3503.7 29777.0 30799.1 31595.2 31609.0 31642.5 2707.9 2722.3 2831.3 2878.3 2881.0 392127.0 396142.0 397774.0 398210.0 398329.0 70212.0 70911.3 71660.9 71860.3 72173.3 78388.6 78973.2 79031.2 79143.0 79146.8 16939.3 17107.7 17112.7 17152.5 17164.1 12885.8 12917.7 12961.7 12974.7 13020.5 22133.4 23245.9 23282.4 23357.6 23362.4 10076.3 10077.6 10360.6 10360.7 10363.7 803.6 857.6 923.4 958.3 1017.1 26292.3 26645.6 27082.6 27566.3 27958.3 1105.5 1107.8 1127.2 1159.7 1206.8 14283.4 14330.4 14337.7 14413.6 14551.1 512011.0 514760.0 517985.0 518055.0 518642.0 57726.1 58096.4 58183.7 58205.7 58233.0 1351.4 1466.5 1493.7 1505.4 1515.8 27426.9 27448.6 28078.6 28119.7 28333.3 43710.9 43833.8 44245.3 44325.1 44427.8 285544.0 286757.0 287793.0 288385.0 288906.0 28541.9 32696.0 32831.7 33365.2 33412.5 39358.8 40129.8 40261.4 40356.6 41453.6 33847.7 34734.5 34763.0 35356.6 35652.5 35778.5 35887.8 35920.3 36736.6 36946.1 29538.6 35289.3 35468.3 35536.1 36698.8 31451.8 31823.8 31864.5 31939.5 32175.0 23340.1 23672.6 23676.4 24029.9 24040.0 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33907.23 Median:25735.55 stddev:106022.17 (412.0%) stddev-sans-first:106289.66 01:43:57 INFO - PROCESS | 1667 | Values: 356.0 356.3 356.9 361.4 366.2 17311.0 19738.8 20921.8 20927.4 20952.3 19806.4 20598.2 20686.5 21166.4 21168.6 5811.5 6050.8 6072.4 6074.3 6092.8 4237.6 4549.0 5935.9 6611.7 6629.5 6267.8 6412.8 6439.4 6532.2 6546.6 5489.2 6163.9 6305.6 6401.9 6408.4 5487.5 5498.1 5506.0 5513.6 5515.1 25024.6 25370.4 25705.2 25765.9 25861.0 2157.4 2168.3 2211.3 2219.5 2838.9 14315.5 14363.3 14398.0 14952.4 15003.8 1730.0 1747.4 1754.1 1774.8 1788.8 93751.5 95371.5 96227.0 96719.5 98709.0 10292.2 10299.4 10721.1 10743.1 10853.0 12716.4 12790.7 12813.0 12826.5 12853.4 8323.0 8501.0 8519.9 8616.9 8619.4 8677.7 8743.0 8758.7 8824.0 8857.9 5206.4 6166.6 6264.8 6271.0 6283.1 1805.3 1843.5 1863.5 1875.0 1884.8 934.5 986.3 987.5 1011.6 1035.1 18004.5 18916.0 19747.8 20263.8 20988.3 883.0 974.4 996.8 1002.8 1035.2 11320.7 11398.4 11524.3 11566.7 11585.5 639152.0 640256.0 643396.0 653401.0 655469.0 63464.7 63746.0 63750.7 98966.5 102708.5 1016.3 1071.8 1071.8 1080.9 1104.4 17430.7 17661.8 17706.1 17732.3 17890.7 41250.0 43058.0 45699.5 47651.8 47941.3 64535.7 65093.7 65140.7 65182.0 65254.0 7881.1 8046.5 8079.3 8150.3 8357.4 11566.9 12325.0 12556.9 13196.6 13531.5 11208.4 11479.4 11564.1 11584.4 11629.3 9911.4 10317.7 11129.4 11433.5 11711.6 11336.7 11627.7 11857.9 11907.6 11968.7 6733.5 6779.4 7944.8 8156.8 8359.7 11231.2 11678.4 11765.8 11866.6 12007.6 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6015.65 Median:2952.96 stddev:3174.77 (107.5%) stddev-sans-first:3164.85 01:43:57 INFO - PROCESS | 1667 | Values: 1416.8 1562.4 1578.3 1876.3 2033.7 7949.4 8524.9 8755.1 8772.6 8774.3 8357.2 8607.9 8610.7 8614.8 8614.9 2171.0 2223.3 2234.4 2437.9 2465.5 2451.1 2515.2 2518.2 2520.8 2521.8 2380.5 2400.7 2406.9 2417.3 2419.0 2425.7 2437.2 2442.5 2451.8 2477.4 2450.5 2460.2 2466.3 2469.3 2482.3 8749.7 8805.5 8813.6 8813.7 8816.2 5372.7 5523.1 5523.2 5525.1 5531.7 3497.7 3580.2 3641.3 3646.7 3660.2 950.7 999.8 1041.2 1063.1 1071.8 11763.2 11799.9 11832.3 11837.1 11847.1 4916.4 4964.3 4984.4 5001.4 5004.1 10046.3 10048.0 10051.1 10056.2 10081.9 5491.1 5514.0 5525.6 5535.1 5542.3 4455.1 4617.2 4674.6 5028.8 5041.0 3902.0 3948.8 3958.6 3983.2 4002.7 1296.9 1310.9 1311.4 1321.6 1322.3 1348.8 1356.8 1364.5 1384.8 1389.3 8219.9 8247.5 8251.9 8265.2 8284.8 509.3 525.6 529.9 532.1 533.3 5016.8 6210.6 6229.3 6251.0 6280.1 10269.5 10627.6 10636.1 10744.0 10755.7 10009.2 10552.2 10600.6 10607.7 10620.0 7354.7 7685.0 7948.0 8116.3 8140.9 8023.8 8045.9 8078.5 8123.0 8183.4 8281.8 8937.1 9369.0 9504.2 9600.9 9571.3 9721.4 9879.2 10112.7 10134.7 6832.5 7016.9 7295.9 7485.7 7628.7 8092.1 8423.9 8441.1 8451.4 8455.6 7213.8 7360.8 7509.8 7628.8 7685.2 7167.1 7197.5 7233.3 7251.3 7380.3 7629.2 7647.6 7676.0 7687.7 7704.5 6788.4 6926.6 6967.6 6969.7 6975.2 7107.3 7159.5 7164.4 7168.5 7186.0 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5676.53 Median:6463.14 stddev:1824.29 (28.2%) stddev-sans-first:1784.64 01:43:57 INFO - PROCESS | 1667 | Values: 325.1 328.2 332.2 335.2 337.5 6397.8 6453.5 6462.1 6464.2 6495.1 5798.6 5904.6 6417.4 6446.5 6460.1 4563.6 4641.5 4683.3 4779.5 4806.9 4721.6 4722.3 4749.9 4752.2 4752.4 4670.8 4701.2 4715.1 4727.5 4738.3 4518.1 4582.8 4702.1 4703.8 4721.8 4073.9 4078.3 4082.6 4082.9 4086.0 6115.8 6234.9 6291.8 6304.6 6305.6 5612.6 5613.5 5620.4 5626.7 5632.3 6897.7 6899.2 6916.3 6918.3 6919.4 3737.3 4305.6 4468.6 4499.9 4520.2 6606.7 6943.8 7343.0 7345.7 7356.8 4582.5 4593.1 4595.0 4597.9 4599.5 4649.5 4651.6 4652.5 4653.6 4664.7 5522.4 5524.1 5524.9 5534.3 5537.7 6720.2 6942.9 6985.3 6995.9 7025.2 1590.8 1598.1 1613.9 1614.2 1621.7 974.8 1007.8 1028.3 1033.2 1061.2 6404.9 6529.9 6538.2 6559.3 6589.3 5919.8 7213.5 7231.6 7246.2 7253.8 6526.1 6527.9 6551.3 6581.2 6584.0 3771.2 3803.6 3806.9 3811.0 3817.9 7262.8 7543.5 7561.2 7570.0 7597.5 7400.1 7407.8 7445.7 7462.6 7469.7 7542.8 7544.8 7557.2 7567.9 7570.2 6920.9 7219.7 7224.4 7229.0 7239.4 7010.3 7117.0 7163.5 7171.1 7177.6 7569.5 7577.5 7586.2 7587.3 7587.5 4559.8 4603.4 4606.3 4607.4 4609.5 6971.3 7218.3 7219.6 7226.8 7237.3 5912.8 6838.3 6976.9 6999.7 7096.8 6896.0 6963.4 6966.2 6971.3 6994.4 6824.8 6840.7 6842.6 6843.8 6855.8 6697.0 6987.0 6994.9 7005.5 7005.6 5524.0 6512.2 6605.0 6691.9 6866.8 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18182.40 Median:66409.83 stddev:25721.92 (38.7%) stddev-sans-first:25760.75 01:43:57 INFO - PROCESS | 1667 | Values: 745.9 748.6 749.5 768.3 802.8 15039.7 15233.2 15358.8 15370.5 15370.7 13980.0 14177.8 14194.8 14202.3 14213.7 742.7 744.9 894.5 927.2 927.3 926.2 929.0 930.1 931.6 932.8 981.5 991.2 992.8 994.1 996.5 764.4 966.0 983.5 984.1 991.1 733.6 738.2 738.8 739.2 739.7 15220.4 15241.7 15252.5 15266.0 15305.2 12509.6 12594.2 12600.0 12681.9 12953.2 9919.3 10065.4 10290.1 10400.3 10847.7 3544.9 3548.8 3583.3 3628.4 3643.2 78446.0 81972.0 82022.2 82145.0 82489.6 7916.3 9786.0 9803.8 9847.8 9916.8 22615.4 22744.4 22749.7 22769.5 22775.8 7403.3 7407.6 7507.7 7687.7 7787.3 4010.0 4044.0 4055.0 4082.2 4104.7 3634.8 3660.8 3682.7 3685.2 3686.0 695.9 704.9 713.6 714.5 726.2 537.7 575.9 592.3 609.1 617.5 7632.2 7944.0 7967.7 8141.7 8244.8 492.5 562.3 602.1 605.6 608.1 3421.5 3770.7 3771.4 3831.1 4010.6 90539.5 91353.0 92434.6 92860.0 93185.1 76261.6 77258.6 77444.6 77813.6 78047.0 66261.7 66558.0 66615.7 68105.3 68560.0 7561.9 7564.9 7697.8 7860.3 7958.2 49032.8 50562.5 50782.0 50833.2 51386.5 65459.0 69603.0 69741.0 72119.9 73507.0 10129.9 10206.5 10363.0 10614.0 10719.7 10743.2 10750.8 10984.7 11058.8 11844.3 10293.9 10358.9 10533.0 10743.7 10756.0 10316.1 10408.1 10436.2 10621.7 10644.3 10159.0 10411.3 10447.9 10493.5 10525.5 8662.8 8861.0 8968.9 8990.9 9008.9 8671.3 8740.5 8793.0 8815.2 8980.8 01:43:57 INFO - PROCESS | 1667 | -------- Summary: end -------- 01:43:57 INFO - PROCESS | 1667 | 01:43:57 INFO - TEST-INFO | 1667: exit 0 01:43:57 INFO - TEST-OK | dromaeo_css | took 1113708ms 01:43:57 INFO - TEST-START | kraken 01:43:57 INFO - operating with platform_type : mac_ 01:43:57 INFO - Initialising browser for kraken test... 01:43:57 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpYboCta/profile http://localhost:49271/getInfo.html) 01:43:59 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 01:43:59 INFO - PROCESS | 1677 | colorDepth:24 01:43:59 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 01:43:59 INFO - PROCESS | 1677 | __metrics 01:43:59 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:43:59 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:44:00 INFO - TEST-INFO | 1677: exit 0 01:44:00 INFO - Browser initialized. 01:44:00 INFO - Running cycle 1/1 for kraken test... 01:44:00 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpYboCta/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:12 INFO - PROCESS | 1679 | RSS: Main: 243216384 01:44:12 INFO - PROCESS | 1679 | 01:44:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:15 INFO - PROCESS | 1679 | RSS: Main: 288694272 01:44:15 INFO - PROCESS | 1679 | 01:44:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 01:44:18 INFO - PROCESS | 1679 | RSS: Main: 299565056 01:44:18 INFO - PROCESS | 1679 | 01:44:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 01:44:22 INFO - PROCESS | 1679 | RSS: Main: 286617600 01:44:22 INFO - PROCESS | 1679 | 01:44:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 01:44:25 INFO - PROCESS | 1679 | RSS: Main: 289038336 01:44:25 INFO - PROCESS | 1679 | 01:44:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:27 INFO - PROCESS | 1679 | RSS: Main: 289742848 01:44:27 INFO - PROCESS | 1679 | 01:44:30 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:31 INFO - PROCESS | 1679 | RSS: Main: 289398784 01:44:31 INFO - PROCESS | 1679 | 01:44:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:34 INFO - PROCESS | 1679 | RSS: Main: 290537472 01:44:34 INFO - PROCESS | 1679 | 01:44:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 01:44:38 INFO - PROCESS | 1679 | RSS: Main: 291717120 01:44:38 INFO - PROCESS | 1679 | 01:44:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:40 INFO - PROCESS | 1679 | RSS: Main: 324272128 01:44:40 INFO - PROCESS | 1679 | 01:44:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:42 INFO - PROCESS | 1679 | RSS: Main: 324685824 01:44:42 INFO - PROCESS | 1679 | 01:44:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:45 INFO - PROCESS | 1679 | RSS: Main: 330534912 01:44:45 INFO - PROCESS | 1679 | 01:44:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:48 INFO - PROCESS | 1679 | RSS: Main: 331014144 01:44:48 INFO - PROCESS | 1679 | 01:44:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:51 INFO - PROCESS | 1679 | RSS: Main: 332537856 01:44:51 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 01:44:53 INFO - PROCESS | 1679 | RSS: Main: 393105408 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | __start_tp_report 01:44:53 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 01:44:53 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 01:44:53 INFO - PROCESS | 1679 | |i|pagename|runs| 01:44:53 INFO - PROCESS | 1679 | |0;ai-astar;111;109;111;111;112;110;116;110;110;111 01:44:53 INFO - PROCESS | 1679 | |1;audio-beat-detection;155;120;145;192;150;143;140;114;186;100 01:44:53 INFO - PROCESS | 1679 | |2;audio-dft;184;185;185;184;183;181;183;184;180;179 01:44:53 INFO - PROCESS | 1679 | |3;audio-fft;72;74;85;77;56;57;58;81;76;72 01:44:53 INFO - PROCESS | 1679 | |4;audio-oscillator;90;92;112;79;106;124;110;73;105;162 01:44:53 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;87;104;87;75;135;129;89;84;87;85 01:44:53 INFO - PROCESS | 1679 | |6;imaging-darkroom;100;122;94;93;92;92;93;93;93;92 01:44:53 INFO - PROCESS | 1679 | |7;imaging-desaturate;84;85;85;84;85;85;87;83;85;85 01:44:53 INFO - PROCESS | 1679 | |8;json-parse-financial;57;55;58;55;54;55;56;66;56;52 01:44:53 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;66;81;73;70;69;66;92;100;90 01:44:53 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;82;71;81;82;82;82;82;83;82;82 01:44:53 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;124;126;132;132;121;138;134;131;128;121 01:44:53 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;138;125;141;139;141;126;135;165;142;136 01:44:53 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;66;67;65;67;66 01:44:53 INFO - PROCESS | 1679 | __end_tp_report 01:44:53 INFO - PROCESS | 1679 | __start_cc_report 01:44:53 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1247 01:44:53 INFO - PROCESS | 1679 | __end_cc_report 01:44:53 INFO - PROCESS | 1679 | __startTimestamp1457689493683__endTimestamp 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | ------- Summary: start ------- 01:44:53 INFO - PROCESS | 1679 | Number of tests: 14 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:2.03 01:44:53 INFO - PROCESS | 1679 | Values: 111.0 109.0 111.0 111.0 112.0 110.0 116.0 110.0 110.0 111.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:147.50 stddev:29.16 (19.8%) stddev-sans-first:30.68 01:44:53 INFO - PROCESS | 1679 | Values: 155.0 120.0 145.0 192.0 150.0 143.0 140.0 114.0 186.0 100.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:182.80 Median:184.00 stddev:2.10 (1.1%) stddev-sans-first:2.18 01:44:53 INFO - PROCESS | 1679 | Values: 184.0 185.0 185.0 184.0 183.0 181.0 183.0 184.0 180.0 179.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:70.80 Median:75.00 stddev:10.32 (13.8%) stddev-sans-first:10.93 01:44:53 INFO - PROCESS | 1679 | Values: 72.0 74.0 85.0 77.0 56.0 57.0 58.0 81.0 76.0 72.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:117.50 stddev:25.34 (21.6%) stddev-sans-first:26.26 01:44:53 INFO - PROCESS | 1679 | Values: 90.0 92.0 112.0 79.0 106.0 124.0 110.0 73.0 105.0 162.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:86.00 stddev:20.20 (23.5%) stddev-sans-first:21.15 01:44:53 INFO - PROCESS | 1679 | Values: 87.0 104.0 87.0 75.0 135.0 129.0 89.0 84.0 87.0 85.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:93.00 stddev:9.30 (10.0%) stddev-sans-first:9.77 01:44:53 INFO - PROCESS | 1679 | Values: 100.0 122.0 94.0 93.0 92.0 92.0 93.0 93.0 93.0 92.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 01:44:53 INFO - PROCESS | 1679 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 87.0 83.0 85.0 85.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.75 (6.7%) stddev-sans-first:3.97 01:44:53 INFO - PROCESS | 1679 | Values: 57.0 55.0 58.0 55.0 54.0 55.0 56.0 66.0 56.0 52.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:77.10 Median:71.50 stddev:12.82 (17.9%) stddev-sans-first:12.69 01:44:53 INFO - PROCESS | 1679 | Values: 64.0 66.0 81.0 73.0 70.0 69.0 66.0 92.0 100.0 90.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:82.00 stddev:3.51 (4.3%) stddev-sans-first:3.70 01:44:53 INFO - PROCESS | 1679 | Values: 82.0 71.0 81.0 82.0 82.0 82.0 82.0 83.0 82.0 82.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:131.50 stddev:5.68 (4.3%) stddev-sans-first:5.76 01:44:53 INFO - PROCESS | 1679 | Values: 124.0 126.0 132.0 132.0 121.0 138.0 134.0 131.0 128.0 121.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.00 stddev:10.97 (7.8%) stddev-sans-first:11.63 01:44:53 INFO - PROCESS | 1679 | Values: 138.0 125.0 141.0 139.0 141.0 126.0 135.0 165.0 142.0 136.0 01:44:53 INFO - PROCESS | 1679 | 01:44:53 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:44:53 INFO - PROCESS | 1679 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 67.0 65.0 67.0 66.0 01:44:53 INFO - PROCESS | 1679 | -------- Summary: end -------- 01:44:53 INFO - PROCESS | 1679 | 01:44:54 INFO - TEST-INFO | 1679: exit 0 01:44:54 INFO - TEST-OK | kraken | took 56922ms 01:44:54 INFO - SUITE-END | took 1170s 01:44:54 INFO - Completed test suite (00:19:31) 01:44:54 INFO - javascript benchmark 01:44:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2756.779457643389, 3265.905921516292, 3434.141464633842, 3436.3127374525084, 3502.4045912194943, 5489.560835133189, 5562.638428502145, 5592.328920529537, 5595.356533998592, 5610.971945140273, 5576.996140694673, 5621.437856214377, 5624.831255062355, 5634.0, 5637.210790489335, 4320.848770293041, 4369.868903932887, 4950.960298337344, 5127.564157046656, 5157.7936882524655, 5111.923321150167, 5156.432792392852, 5178.378594568657, 5181.404138524062, 5198.0383629028565, 4483.834203107183, 4996.675216110941, 5066.898662026757, 5153.201253805666, 5162.354705661793, 5130.486951304877, 5170.508801663836, 5180.119379705459, 5199.896002079975, 5242.842714718565, 4947.604191664658, 4981.2030075187795, 5073.77168027436, 5109.565686916617, 5120.974395128038, 5495.175723641446, 5499.1476321170285, 5544.500994910437, 5556.138798486241, 5615.578831587606, 6141.692915354259, 6155.045967874987, 6173.753049878, 6174.475169610589, 6189.6286222826775, 6041.033434650435, 6054.589585391162, 6191.823962049801, 6214.65819379934, 6250.187475628185, 5701.173329867146, 5701.800436984686, 5711.742971566248, 5747.798827041033, 5764.279465066867, 6246.0, 6314.305426403092, 6319.905201421982, 6324.241091069009, 6327.683615819191, 5066.138756411419, 5893.145493903446, 5936.257967754031, 6064.9090263646085, 6096.420840020191, 6155.114855734774, 6197.96901015501, 6205.844853878689, 6223.96888015557, 6226.0, 6103.0, 6152.938470615326, 6164.229471316085, 6169.84575385619, 6177.81466556004, 5985.670788106696, 6103.908441373383, 6171.753129874754, 6185.8144255672405, 6199.5660303779205, 4869.878253043702, 4872.317875497433, 4881.658283920092, 4886.218205087169, 4916.213405855046, 4091.8363265469643, 4342.08816148606, 4356.978215108904, 4365.454318210223, 4389.100234451929, 5042.218456139304, 5580.162975553618, 5608.915866262009, 5623.465770751772, 5647.604667673223, 6160.722767475474, 6164.815055548341, 6168.074788781629, 6172.69136543171, 6177.598456100339, 5566.415526369754, 5682.090865461506, 5719.084946408555, 5720.313562372542, 5720.542356611461, 5324.0, 5333.599980001438, 5339.5728341732565, 5344.43883392246, 5345.33183352081, 6224.253089629274, 6238.344973777779, 6294.874102517924, 6306.369363063749, 6307.684615769193, 6130.887362651087, 6307.716152773044, 6316.431521163117, 6319.873602527831, 6322.810315690536, 6225.595336303126, 6267.373262673696, 6281.71732272058, 6289.7484100635465, 6300.810975670737, 5814.418558144152, 5938.287405511366, 5942.851428714317, 5947.9405205949115, 5991.970040149946, 6132.08018797184, 6187.16473276102, 6208.844778880564, 6215.782447614311, 6227.532935029982, 5944.910826337695, 6005.249343832021, 6007.038873780174, 6011.639301641915, 6065.969670151621, 5768.769249229984, 5913.319968203539, 5961.135635332766, 5986.491148252448, 6000.5799594028, 4470.619997300266, 5787.56593255516, 5791.420857914175, 5803.622764520293, 5843.7370318336625, 5898.646081234968, 5944.8811023780145, 5963.642181469126, 5972.283326000907, 6027.60820546663, 5664.773409063756, 5811.970940145272, 5813.389594092729, 5816.883662326814, 5833.591648584728], "unit": "score", "name": "dojo.html", "value": 5587.605436042735}, {"lowerIsBetter": false, "replicates": [495.4475759528127, 575.516566084489, 577.7607032914399, 628.7453581299574, 632.4782054804786, 26496.735032649667, 38645.42031869524, 38952.61047389525, 39027.12160979881, 39091.60908390922, 41906.0, 42316.788416057876, 42356.57643423565, 42423.0, 42425.78787106068, 9508.239340852733, 9756.756081097958, 9762.609495620167, 9765.414075155513, 9838.311318207729, 9493.762655933588, 9651.986541413156, 9659.855102173473, 9672.419654820698, 9820.165285950703, 9773.21814254858, 9841.311108222428, 9852.458114803683, 9856.457894815781, 9872.506374681274, 9771.316007879452, 9833.26250531213, 9840.803183936352, 9845.753856153618, 9875.851862222073, 9679.612815487371, 9756.268279879037, 9773.853392199122, 9784.608615655365, 9806.558704858298, 40410.39384409236, 40848.795756021325, 40878.59121408778, 40882.79558602218, 40941.0, 2918.8394638294885, 3251.561039259693, 3264.7061764441078, 3476.513288139637, 3503.7147102526, 29777.0, 30799.076027719206, 31595.21011974719, 31609.0, 31642.525362119588, 2707.891684332624, 2722.278596171996, 2831.3327558470487, 2878.29481776966, 2880.9711902880913, 392127.0, 396141.9999999971, 397774.0, 398210.0, 398329.0, 70212.0, 70911.2908870915, 71660.92508612375, 71860.28139718641, 72173.27826721771, 78388.60805695935, 78973.21026789774, 79031.20968790354, 79143.0, 79146.81279780807, 16939.32242710278, 17107.657846842994, 17112.657746844994, 17152.48542543726, 17164.05597692139, 12885.806712899313, 12917.741645167232, 12961.740765184644, 12974.675633109058, 13020.47918083266, 22133.446663833533, 23245.88377058104, 23282.417939551648, 23357.649635255486, 23362.415939601648, 10076.29465937392, 10077.59689612422, 10360.637377691895, 10360.740981475372, 10363.689089327332, 803.6423791412765, 857.5797859049021, 923.4136323434667, 958.3387462650749, 1017.1252722658655, 26292.342691432867, 26645.60031599489, 27082.593761093598, 27566.310842228704, 27958.301042473693, 1105.5025238642643, 1107.7507560798756, 1127.2334812327697, 1159.6579009192308, 1206.843110395643, 14283.357248923823, 14330.426782928565, 14337.713245735027, 14413.639659008399, 14551.05418147817, 512011.0, 514760.0, 517985.0, 518055.0, 518642.0, 57726.134107988415, 58096.419035809944, 58183.70908145432, 58205.70897145487, 58233.0, 1351.4053816320788, 1466.4647403697575, 1493.7460631692638, 1505.427937383809, 1515.7953676253785, 27426.862865685544, 27448.588271175548, 28078.57882131729, 28119.718802812527, 28333.291667708472, 43710.90722731957, 43833.78083109692, 44245.336319954586, 44325.11349773051, 44427.77786111178, 285544.0, 286757.0, 287793.0, 288385.0, 288906.0, 28541.85832566674, 32696.0, 32831.671683283814, 33365.16587085342, 33412.49881251735, 39358.803205983786, 40129.79610611686, 40261.39607905825, 40356.59643403528, 41453.58546414497, 33847.66152338445, 34734.47898281477, 34763.0, 35356.64643353534, 35652.46521302235, 35778.463323049655, 35887.82056089703, 35920.28159436744, 36736.63263367332, 36946.07634809151, 29538.55692164662, 35289.29421411609, 35468.290634186655, 35536.11159721028, 36698.8165059173, 31451.754013207923, 31823.840880795447, 31864.522032169072, 31939.520907185946, 32175.0, 23340.066397343915, 23672.61030141727, 23676.408089797893, 24029.918653660978, 24040.038398463865], "unit": "score", "name": "ext.html", "value": 19535.264964471076}, {"lowerIsBetter": false, "replicates": [355.9519464872243, 356.3176516970002, 356.90964104660253, 361.35498135827544, 366.19985332049475, 17311.0, 19738.802611973875, 20921.790782092176, 20927.37217883466, 20952.26667066651, 19806.40580782575, 20598.21924040254, 20686.48283792906, 21166.365009049754, 21168.57662846746, 5811.506021988125, 6050.788222412217, 6072.423119803611, 6074.331823499434, 6092.847678808043, 4237.597428244312, 4548.999220171557, 5935.88128237435, 6611.669416529178, 6629.4696424286185, 6267.780627678032, 6412.775552855651, 6439.356064393546, 6532.150820393343, 6546.639934803584, 5489.231507588941, 6163.87672246557, 6305.558610897239, 6401.9039714404325, 6408.391202835746, 5487.533559647435, 5498.092814685572, 5505.9724701376235, 5513.558915286768, 5515.09001014832, 25024.624630630555, 25370.365740856625, 25705.228843134737, 25765.871170644215, 25861.0, 2157.431790011305, 2168.316980151263, 2211.347652442533, 2219.5006123622215, 2838.929026774347, 14315.49895753654, 14363.281835908163, 14398.0, 14952.40190392383, 15003.774943375858, 1730.0398278955174, 1747.4320845725063, 1754.0878743053668, 1774.7604073450048, 1788.794288656808, 93751.53124234403, 95371.52314238454, 96227.0, 96719.51640241753, 98709.02581948321, 10292.176625869912, 10299.433531155708, 10721.088707459798, 10743.086837618734, 10853.023227909369, 12716.364181790874, 12790.68023299425, 12813.0, 12826.486940522462, 12853.357332133355, 8323.0, 8501.0, 8519.872201916976, 8616.870746938801, 8619.396642234984, 8677.696280630147, 8743.0, 8758.737237882873, 8824.02935677075, 8857.867131993025, 5206.401263854629, 6166.599171053867, 6264.780732674334, 6271.0, 6283.120363149163, 1805.3320271499629, 1843.5483306589972, 1863.4968558489131, 1875.0, 1884.7644044494439, 934.5420743835472, 986.2898712926682, 987.4914419074182, 1011.5650270383805, 1035.140833108518, 18004.54988625295, 18915.973444249128, 19747.802521974885, 20263.79736202619, 20988.26541071055, 882.9735107946772, 974.3715303629261, 996.8006398720285, 1002.7994401119805, 1035.1822060572215, 11320.716982075513, 11398.385884203877, 11524.308541487537, 11566.65300041, 11585.536578536765, 639152.0, 640256.0, 643396.0, 653401.0, 655469.0, 63464.68267658632, 63746.0, 63750.72498550096, 98966.5051674737, 102708.48645756724, 1016.3190662256306, 1071.7910007548453, 1071.807074726541, 1080.935143891369, 1104.4091411095187, 17430.738538921672, 17661.82338176602, 17706.118945676997, 17732.29070837152, 17890.731639025165, 41250.0, 43058.0, 45699.54300456953, 47651.76174119107, 47941.28088078751, 64535.70928581496, 65093.67453162704, 65140.67429662821, 65182.0, 65254.02118968124, 7881.054273487218, 8046.476978996347, 8079.313258373104, 8150.347972162332, 8357.373197010127, 11566.94216528912, 12325.0, 12556.87443125557, 13196.60410187696, 13531.526396576073, 11208.439578020903, 11479.4260286987, 11564.074874010228, 11584.420778961186, 11629.302241865515, 9911.405315681082, 10317.658704368685, 11129.443527823738, 11433.485493152662, 11711.648650540497, 11336.716582085513, 11627.709307267385, 11857.881421186023, 11907.583234587095, 11968.700782480508, 6733.494987876027, 6779.389854913082, 7944.84110317802, 8156.796080098045, 8359.749207523784, 11231.15766317513, 11678.357690327113, 11765.823512647488, 11866.584669536525, 12007.579734709243], "unit": "score", "name": "jquery.html", "value": 9485.819378852642}, {"lowerIsBetter": false, "replicates": [1416.7874818777175, 1562.4062856114674, 1578.3370984186645, 1876.3339014649798, 2033.745781777278, 7949.364050875924, 8524.8721269181, 8755.080716524768, 8772.605232764517, 8774.298056155509, 8357.16428357164, 8607.91392086079, 8610.655573777058, 8614.827703445928, 8614.87077693835, 2170.967435488461, 2223.2774348336775, 2234.3967128875192, 2437.9390515237083, 2465.5315490056923, 2451.117597664839, 2515.195137555983, 2518.244526642009, 2520.8109391795597, 2521.760432758885, 2380.452495925938, 2400.6759087523137, 2406.927792166229, 2417.286900364397, 2418.9879050604723, 2425.7210420801657, 2437.195725410619, 2442.5237078769646, 2451.7915977141965, 2477.3682710908784, 2450.4853980664084, 2460.225029115823, 2466.3217615155795, 2469.259222233323, 2482.3173627252468, 8749.737507874774, 8805.515696636683, 8813.603387847563, 8813.691520796741, 8816.206541411304, 5372.650777699476, 5523.116301391758, 5523.226748255248, 5525.143602741541, 5531.695756733378, 3497.6502349765074, 3580.2481478889463, 3641.3445579795625, 3646.690031347339, 3660.2313514162056, 950.6577632052456, 999.8150342186646, 1041.156663102889, 1063.1016790811752, 1071.833865750802, 11763.176577639568, 11799.882001179963, 11832.349220792852, 11837.053035757204, 11847.111466640037, 4916.385451818523, 4964.329815474937, 4984.42679091909, 5001.44984051754, 5004.149294619923, 10046.296759226783, 10048.0, 10051.095401413908, 10056.245781566411, 10081.949590252001, 5491.121420572769, 5513.972430137904, 5525.640833345819, 5535.142052981794, 5542.251796007487, 4455.108978204372, 4617.238155704338, 4674.649401294916, 5028.84913452597, 5041.0, 3901.9804900975314, 3948.8420463181724, 3958.5843486434087, 3983.2232714620372, 4002.6597739192493, 1296.8703129686955, 1310.8623594522628, 1311.3508813137366, 1321.6167311479755, 1322.2529270961875, 1348.7572236997435, 1356.7939387897636, 1364.5428781358157, 1384.778435450323, 1389.256747640028, 8219.917800821915, 8247.505149691038, 8251.876221856677, 8265.214804593554, 8284.845940055508, 509.34803451582036, 525.5979175930416, 529.9152135658276, 532.0874699889707, 533.2694208933785, 5016.849494515171, 6210.627362358183, 6229.314775374705, 6250.968745156245, 6280.120783090371, 10269.486525673836, 10627.628033018962, 10636.095931845724, 10744.0, 10755.731106722238, 10009.199264058858, 10552.208584356204, 10600.575976960836, 10607.734806629742, 10620.0, 7354.669039893218, 7684.961575192088, 7948.006499187602, 8116.310113640288, 8140.918590814016, 8023.839523209386, 8045.919540804517, 8078.515289082674, 8123.025236971365, 8183.427160098736, 8281.751547453587, 8937.06160853101, 9368.95315523418, 9504.239660827256, 9600.903990960001, 9571.33000689945, 9721.416714997124, 9879.209663227068, 10112.747181320527, 10134.746631334276, 6832.521723479309, 7016.859662806817, 7295.927040729524, 7485.737999170003, 7628.656710448154, 8092.109867914407, 8423.8736418955, 8441.071482136836, 8451.408401411842, 8455.577221139041, 7213.7835864922035, 7360.77917662471, 7509.8498030038, 7628.8474230516185, 7685.154632990255, 7167.104111986002, 7197.532160409557, 7233.31283528064, 7251.274872512707, 7380.33576978053, 7629.198934111839, 7647.617619118911, 7676.040494938133, 7687.692492300245, 7704.499207551491, 6788.355106265094, 6926.58440493572, 6967.581945083311, 6969.686364113526, 6975.232724400414, 7107.324804143598, 7159.534630249017, 7164.426845852215, 7168.462365322517, 7185.964070179824], "unit": "score", "name": "mootools.html", "value": 4832.981926028575}, {"lowerIsBetter": false, "replicates": [325.12865520405313, 328.22047636862453, 332.19277156509673, 335.2022187194477, 337.45164108323956, 6397.776077837277, 6453.5159863010285, 6462.0953066570655, 6464.191976003, 6495.058216558602, 5798.594098413102, 5904.557158213141, 6417.39034791694, 6446.484281257488, 6460.127882735829, 4563.634909207272, 4641.512641172662, 4683.32091846682, 4779.545943135414, 4806.90386192275, 4721.622270218374, 4722.291656251573, 4749.85750427486, 4752.1921273383605, 4752.382190315271, 4670.813167473297, 4701.200795864711, 4715.104130215265, 4727.479977202505, 4738.336632871401, 4518.1415531049, 4582.77086145693, 4702.130105930414, 4703.764811759433, 4721.834735784231, 4073.918521629551, 4078.3474644057105, 4082.6121518455698, 4082.857100001486, 4086.0397806515443, 6115.816525504242, 6234.937650623481, 6291.842703932392, 6304.581469169446, 6305.59013664115, 5612.579056570733, 5613.494785469286, 5620.437956204388, 5626.718664066781, 5632.267805185341, 6897.724091036353, 6899.17209934806, 6916.308369163094, 6918.273581273944, 6919.411849992756, 3737.252549490113, 4305.612494875445, 4468.620167285784, 4499.910001799945, 4520.163769702583, 6606.711691220214, 6943.826404339881, 7343.008693826372, 7345.669444874993, 7356.779296621056, 4582.473015603182, 4593.081383723269, 4595.035042641016, 4597.862064138081, 4599.517050709627, 4649.511801260886, 4651.627869770478, 4652.534746525388, 4653.604443622262, 4664.720116792935, 5522.392536820947, 5524.14375771756, 5524.889502209933, 5534.280543529316, 5537.6954267515675, 6720.1599800025, 6942.93057069433, 6985.301469853076, 6995.915633076881, 7025.192102908231, 1590.7852439920462, 1598.1130472587593, 1613.9273732682057, 1614.160636469053, 1621.691878543073, 974.8050389922043, 1007.808516381885, 1028.311031608824, 1033.178622994721, 1061.2200032975757, 6404.935950640527, 6529.869402611921, 6538.1827271591055, 6559.311272316433, 6589.308122647149, 5919.822405327847, 7213.531120477152, 7231.566106033655, 7246.239144889816, 7253.782386528413, 6526.053722210253, 6527.934720652827, 6551.312112228147, 6581.243157036906, 6583.979483180115, 3771.2080463102507, 3803.6006219347123, 3806.923861522754, 3811.0091376242376, 3817.9427308590393, 7262.818429539304, 7543.547387156788, 7561.2060733622175, 7570.0, 7597.544147351176, 7400.074990626172, 7407.8148046299275, 7445.739399121005, 7462.626868656545, 7469.701211951569, 7542.773716788505, 7544.849103017909, 7557.183622270718, 7567.9243207567215, 7570.1672815989095, 6920.861582768216, 7219.6751146199595, 7224.385927196247, 7228.951801988787, 7239.420846332176, 7010.298970103153, 7116.964415177891, 7163.534370265916, 7171.067761191011, 7177.605231712306, 7569.545827250383, 7577.507462014952, 7586.24137586237, 7587.317141457295, 7587.544747315179, 4559.772011399483, 4603.355530225704, 4606.262997920317, 4607.40103786519, 4609.539046095364, 6971.26801685836, 7218.27817218295, 7219.60292183935, 7226.783196504113, 7237.299234679951, 5912.822615321547, 6838.316168383122, 6976.860462790817, 6999.720011199495, 7096.7516136934955, 6896.0, 6963.40811031068, 6966.164060312795, 6971.302869713191, 6994.405475534433, 6824.7952561423235, 6840.657967101724, 6842.55523390978, 6843.7604683835825, 6855.794326170223, 6696.966515167393, 6986.9650651746415, 6994.895076573754, 7005.474589405917, 7005.649717514206, 5524.0, 6512.218533775787, 6605.0, 6691.866162676622, 6866.759663411756], "unit": "score", "name": "prototype.html", "value": 5065.900374494194}, {"lowerIsBetter": false, "replicates": [745.8545583611194, 748.5508694783127, 749.4528993834504, 768.2739810878718, 802.8474589827935, 15039.699206015886, 15233.162176080312, 15358.769618455732, 15370.53888383349, 15370.692586148285, 13980.0, 14177.787333189985, 14194.787078193835, 14202.28988550571, 14213.71572568548, 742.6917829100917, 744.8957145999565, 894.5437826708361, 927.1609193679731, 927.3091546797646, 926.1988380051241, 929.0245242495387, 930.1303281431883, 931.6273490603745, 932.822763674903, 981.4847205217283, 991.1624677147798, 992.8361820299642, 994.0804755601076, 996.5017491254373, 764.4152223548989, 966.0436168193509, 983.503330817936, 984.0848011349442, 991.1426615977127, 733.6111860713777, 738.1843063414902, 738.759903031517, 739.161052205745, 739.7484855149221, 15220.391184352613, 15241.695166096726, 15252.466163684328, 15266.0, 15305.1582162981, 12509.56216532417, 12594.24434533931, 12600.0, 12681.936590317082, 12953.222806631633, 9919.256055795844, 10065.396076235449, 10290.07389334956, 10400.323978941344, 10847.728806779814, 3544.8759293424605, 3548.822558872046, 3583.2654305867236, 3628.401313783249, 3643.234920666663, 78446.0, 81972.0, 82022.17977820204, 82145.0, 82489.58755206245, 7916.287534121957, 9785.951070244602, 9803.803923921481, 9847.75380615476, 9916.752081197883, 22615.43461413445, 22744.431389215402, 22749.658755118686, 22769.544609107725, 22775.772242277366, 7403.259674032553, 7407.555546667109, 7507.737229196952, 7687.730929417444, 7787.299143077037, 4010.037590978144, 4043.959560404417, 4054.959450405517, 4082.2243773682903, 4104.733192342548, 3634.83643236055, 3660.798656073888, 3682.7294583368694, 3685.244524872395, 3685.963140368562, 695.9095317608678, 704.9083619129583, 713.6467448612866, 714.5498336048256, 726.2374506767873, 537.725759862473, 575.8761866198787, 592.3424998252023, 609.1046162141645, 617.4998251416367, 7632.204958743475, 7943.9602801986775, 7967.681292748225, 8141.674333026731, 8244.83510329802, 492.53455484567456, 562.2943206276097, 602.0908428273339, 605.5609682979805, 608.1182285685774, 3421.5380923575, 3770.698344132463, 3771.4342848572387, 3831.061389959422, 4010.578889216649, 90539.54730226439, 91353.0, 92434.61348079784, 92860.0, 93185.06814931764, 76261.61869190619, 77258.61370693111, 77444.61277693576, 77813.61093194498, 78047.0, 66261.66869165623, 66558.0, 66615.66692166508, 68105.31894681089, 68560.0, 7561.924380756122, 7564.924350756422, 7697.807554811175, 7860.331871790733, 7958.243966823143, 49032.75483622559, 50562.49437505578, 50782.0, 50833.2041737708, 51386.48613513967, 65459.0, 69602.9559556597, 69741.0, 72119.91820122808, 73507.0, 10129.949350253202, 10206.540705668114, 10363.015513526203, 10613.991670791262, 10719.732006699895, 10743.24797264184, 10750.8387374191, 10984.670459886216, 11058.778824423627, 11844.28934263947, 10293.9485302576, 10358.896411035794, 10533.0, 10743.677689669323, 10756.0, 10316.123129534073, 10408.115310198718, 10436.217283703905, 10621.734456638645, 10644.254902156774, 10159.0, 10411.271211015459, 10447.94776026115, 10493.527791249564, 10525.526351314056, 8662.82674346497, 8860.955695221483, 8968.865467018131, 8990.91009089927, 9008.90991090107, 8671.262942649946, 8740.519271440131, 8792.956035219782, 8815.206631403205, 8980.820383592421], "unit": "score", "name": "yui.html", "value": 6853.712336125028}], "name": "dromaeo_css", "value": 7470.085499791428}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 111.0, 112.0, 110.0, 116.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 145.0, 192.0, 150.0, 143.0, 140.0, 114.0, 186.0, 100.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 185.0, 184.0, 183.0, 181.0, 183.0, 184.0, 180.0, 179.0], "unit": "score", "name": "audio-dft", "value": 182.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 85.0, 77.0, 56.0, 57.0, 58.0, 81.0, 76.0, 72.0], "unit": "score", "name": "audio-fft", "value": 70.8}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 112.0, 79.0, 106.0, 124.0, 110.0, 73.0, 105.0, 162.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [87.0, 104.0, 87.0, 75.0, 135.0, 129.0, 89.0, 84.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.2}, {"lowerIsBetter": true, "replicates": [100.0, 122.0, 94.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 96.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 87.0, 83.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 58.0, 55.0, 54.0, 55.0, 56.0, 66.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 81.0, 73.0, 70.0, 69.0, 66.0, 92.0, 100.0, 90.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.1}, {"lowerIsBetter": true, "replicates": [82.0, 71.0, 81.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.9}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 132.0, 132.0, 121.0, 138.0, 134.0, 131.0, 128.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [138.0, 125.0, 141.0, 139.0, 141.0, 126.0, 135.0, 165.0, 142.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1440.1}]} 01:44:54 INFO - Return code: 0 01:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:44:54 ERROR - # TBPL SUCCESS # 01:44:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:44:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:44:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:44:54 INFO - 2016-03-11 01:44:54.995 screenresolution[1683:9547] starting screenresolution argv=screenresolution get 01:44:54 INFO - 2016-03-11 01:44:54.998 screenresolution[1683:9547] Display 0: 1600x1200x32@60 01:44:55 INFO - 2016-03-11 01:44:55.003 screenresolution[1684:9551] starting screenresolution argv=screenresolution list 01:44:55 INFO - Available Modes on Display 0 01:44:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:44:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:44:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:44:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:44:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:44:55 INFO - Intel Iris: 01:44:55 INFO - Chipset Model: Intel Iris 01:44:55 INFO - Type: GPU 01:44:55 INFO - Bus: Built-In 01:44:55 INFO - VRAM (Dynamic, Max): 1536 MB 01:44:55 INFO - Vendor: Intel (0x8086) 01:44:55 INFO - Device ID: 0x0a2e 01:44:55 INFO - Revision ID: 0x0009 01:44:55 INFO - Displays: 01:44:55 INFO - Display: 01:44:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:44:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:44:55 INFO - Display Serial Number: 1600x1200 60 01:44:55 INFO - Main Display: Yes 01:44:55 INFO - Mirror: Off 01:44:55 INFO - Online: Yes 01:44:55 INFO - Rotation: Supported 01:44:55 INFO - Return code: 0 01:44:55 INFO - Running post-action listener: _resource_record_post_action 01:44:55 INFO - Running post-run listener: _resource_record_post_run 01:44:56 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39028224; Write bytes: 703512576; Read time: 434; Write time: 2047 01:44:56 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402297344; Write bytes: 404560896; Read time: 30245; Write time: 750 01:44:56 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37213696; Write bytes: 298103808; Read time: 414; Write time: 1294 01:44:56 INFO - Running post-run listener: _upload_blobber_files 01:44:56 INFO - Blob upload gear active. 01:44:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:44:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:44:56 INFO - (blobuploader) - INFO - Open directory for files ... 01:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:57 INFO - (blobuploader) - INFO - Done attempting. 01:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:58 INFO - (blobuploader) - INFO - Done attempting. 01:44:58 INFO - (blobuploader) - INFO - Iteration through files over. 01:44:58 INFO - Return code: 0 01:44:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:44:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:44:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52319bd06a00a7673d26dc45bed803b4202c10f55ae662ce56bdfb00e87091a7cdccc6df29b51d8b305dc8bd89abb1cb2efff8ccd9fb82115457339e29bae92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d607973daa630c1390bbd17cb10c5ebdc52db5e02f5109115754d7b042e31ab82dea77ae1831b76746b8135b1255b2832eea0014dcee268b84a2f1de520231c5"} 01:44:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:44:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:44:58 INFO - Contents: 01:44:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52319bd06a00a7673d26dc45bed803b4202c10f55ae662ce56bdfb00e87091a7cdccc6df29b51d8b305dc8bd89abb1cb2efff8ccd9fb82115457339e29bae92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d607973daa630c1390bbd17cb10c5ebdc52db5e02f5109115754d7b042e31ab82dea77ae1831b76746b8135b1255b2832eea0014dcee268b84a2f1de520231c5"} 01:44:58 INFO - Running post-run listener: copy_logs_to_upload_dir 01:44:58 INFO - Copying logs to upload dir... 01:44:58 INFO - mkdir: /builds/slave/test/build/upload/logs 01:44:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.420275 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-11 01:44:58.897838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 01:44:58.905353) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52319bd06a00a7673d26dc45bed803b4202c10f55ae662ce56bdfb00e87091a7cdccc6df29b51d8b305dc8bd89abb1cb2efff8ccd9fb82115457339e29bae92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d607973daa630c1390bbd17cb10c5ebdc52db5e02f5109115754d7b042e31ab82dea77ae1831b76746b8135b1255b2832eea0014dcee268b84a2f1de520231c5"} build_url:https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011058 build_url: 'https://queue.taskcluster.net/v1/task/VRHNRd8qTfag0drG4uj2tg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52319bd06a00a7673d26dc45bed803b4202c10f55ae662ce56bdfb00e87091a7cdccc6df29b51d8b305dc8bd89abb1cb2efff8ccd9fb82115457339e29bae92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d607973daa630c1390bbd17cb10c5ebdc52db5e02f5109115754d7b042e31ab82dea77ae1831b76746b8135b1255b2832eea0014dcee268b84a2f1de520231c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 01:44:58.938486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:44:58.938846) ========= 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.DBDevz9UVU/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.4NoCsFA6Li/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005196 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:44:58.990375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 01:44:58.990725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 01:44:58.991127) ========= ========= Total master_lag: 0.30 =========