builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0045 starttime: 1447976542.89 results: success (0) buildid: 20151119131711 builduid: 6d6c9d982c714986b3e8316b1c98c402 revision: a76322320837ac6d0c9510c280706359a47ea309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.888535) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.888965) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.889248) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005385 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.909096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.909398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.923964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.924324) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005359 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.972684) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.972997) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.973359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:22.973629) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 --2015-11-19 15:42:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-19 15:42:23 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:23.108580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:23.109092) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.019405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:23.158784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:23.159151) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a76322320837ac6d0c9510c280706359a47ea309 --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 a76322320837ac6d0c9510c280706359a47ea309 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 2015-11-19 15:42:23,232 truncating revision to first 12 chars 2015-11-19 15:42:23,232 Setting DEBUG logging. 2015-11-19 15:42:23,232 attempt 1/10 2015-11-19 15:42:23,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a76322320837?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 15:42:23,898 unpacking tar archive at: mozilla-central-a76322320837/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917282 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:24.152906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:24.153261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:24.165051) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:24.165433) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:42:24.165850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-19 15:42:24.166142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:42:24 INFO - MultiFileLogger online at 20151119 15:42:24 in /builds/slave/test 15:42:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:42:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:24 INFO - {'append_to_log': False, 15:42:24 INFO - 'base_work_dir': '/builds/slave/test', 15:42:24 INFO - 'blob_upload_branch': 'Firefox', 15:42:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:24 INFO - 'branch': 'Firefox', 15:42:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:24 INFO - 'config_files': ('talos/mac_config.py',), 15:42:24 INFO - 'default_actions': ('clobber', 15:42:24 INFO - 'read-buildbot-config', 15:42:24 INFO - 'download-and-extract', 15:42:24 INFO - 'populate-webroot', 15:42:24 INFO - 'create-virtualenv', 15:42:24 INFO - 'install', 15:42:24 INFO - 'run-tests'), 15:42:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:24 INFO - 'download_minidump_stackwalk': True, 15:42:24 INFO - 'download_symbols': 'ondemand', 15:42:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:42:24 INFO - 'tooltool.py': '/tools/tooltool.py', 15:42:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:42:24 INFO - '/tools/misc-python/virtualenv.py')}, 15:42:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:24 INFO - 'installer_path': 'installer.exe', 15:42:24 INFO - 'log_level': 'info', 15:42:24 INFO - 'log_name': 'talos', 15:42:24 INFO - 'log_to_console': True, 15:42:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:42:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:42:24 INFO - 'opt_config_files': (), 15:42:24 INFO - 'pip_index': False, 15:42:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:24 INFO - 'cmd': ('bash', 15:42:24 INFO - '-c', 15:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:24 INFO - 'enabled': True, 15:42:24 INFO - 'halt_on_failure': False, 15:42:24 INFO - 'name': 'check_screen_resolution'},), 15:42:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:24 INFO - 'cmd': ('bash', 15:42:24 INFO - '-c', 15:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:24 INFO - 'enabled': True, 15:42:24 INFO - 'halt_on_failure': False, 15:42:24 INFO - 'name': 'check_screen_resolution'},), 15:42:24 INFO - 'run_cmd_checks_enabled': True, 15:42:24 INFO - 'sps_profile': False, 15:42:24 INFO - 'sps_profile_interval': 0, 15:42:24 INFO - 'suite': 'dromaeojs-e10s', 15:42:24 INFO - 'system_bits': '64', 15:42:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:24 INFO - 'title': 't-yosemite-r7-0045', 15:42:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:24 INFO - 'use_talos_json': True, 15:42:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:24 INFO - 'work_dir': 'build'} 15:42:24 INFO - ##### 15:42:24 INFO - ##### Running clobber step. 15:42:24 INFO - ##### 15:42:24 INFO - Running pre-action listener: _resource_record_pre_action 15:42:24 INFO - Running main action method: clobber 15:42:24 INFO - rmtree: /builds/slave/test/build 15:42:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - ##### 15:42:25 INFO - ##### Running read-buildbot-config step. 15:42:25 INFO - ##### 15:42:25 INFO - Running pre-action listener: _resource_record_pre_action 15:42:25 INFO - Running main action method: read_buildbot_config 15:42:25 INFO - Using buildbot properties: 15:42:25 INFO - { 15:42:25 INFO - "properties": { 15:42:25 INFO - "buildnumber": 1, 15:42:25 INFO - "product": "firefox", 15:42:25 INFO - "script_repo_revision": "production", 15:42:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:42:25 INFO - "repository": "", 15:42:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:42:25 INFO - "buildid": "20151119131711", 15:42:25 INFO - "slavename": "t-yosemite-r7-0045", 15:42:25 INFO - "pgo_build": "False", 15:42:25 INFO - "basedir": "/builds/slave/test", 15:42:25 INFO - "project": "", 15:42:25 INFO - "platform": "yosemite_r7", 15:42:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:42:25 INFO - "slavebuilddir": "test", 15:42:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:42:25 INFO - "branch": "mozilla-central", 15:42:25 INFO - "repo_path": "mozilla-central", 15:42:25 INFO - "stage_platform": "macosx64", 15:42:25 INFO - "builduid": "6d6c9d982c714986b3e8316b1c98c402", 15:42:25 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:42:25 INFO - }, 15:42:25 INFO - "sourcestamp": { 15:42:25 INFO - "repository": "", 15:42:25 INFO - "hasPatch": false, 15:42:25 INFO - "project": "", 15:42:25 INFO - "branch": "mozilla-central-macosx64-talos", 15:42:25 INFO - "changes": [ 15:42:25 INFO - { 15:42:25 INFO - "category": null, 15:42:25 INFO - "files": [ 15:42:25 INFO - { 15:42:25 INFO - "url": null, 15:42:25 INFO - "name": "https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:42:25 INFO - } 15:42:25 INFO - ], 15:42:25 INFO - "repository": "", 15:42:25 INFO - "rev": "a76322320837ac6d0c9510c280706359a47ea309", 15:42:25 INFO - "who": "kwierso@gmail.com", 15:42:25 INFO - "when": 1447974858, 15:42:25 INFO - "number": 6685686, 15:42:25 INFO - "comments": "Touch CLOBBER to clear up bug 1168113's bustage a=merge", 15:42:25 INFO - "project": "", 15:42:25 INFO - "at": "Thu 19 Nov 2015 15:14:18", 15:42:25 INFO - "branch": "mozilla-central-macosx64-talos", 15:42:25 INFO - "revlink": "", 15:42:25 INFO - "properties": [ 15:42:25 INFO - [ 15:42:25 INFO - "buildid", 15:42:25 INFO - "20151119131711", 15:42:25 INFO - "Change" 15:42:25 INFO - ], 15:42:25 INFO - [ 15:42:25 INFO - "builduid", 15:42:25 INFO - "6d6c9d982c714986b3e8316b1c98c402", 15:42:25 INFO - "Change" 15:42:25 INFO - ], 15:42:25 INFO - [ 15:42:25 INFO - "pgo_build", 15:42:25 INFO - "False", 15:42:25 INFO - "Change" 15:42:25 INFO - ] 15:42:25 INFO - ], 15:42:25 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:42:25 INFO - } 15:42:25 INFO - ], 15:42:25 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:42:25 INFO - } 15:42:25 INFO - } 15:42:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - ##### 15:42:25 INFO - ##### Running download-and-extract step. 15:42:25 INFO - ##### 15:42:25 INFO - Running pre-action listener: _resource_record_pre_action 15:42:25 INFO - Running main action method: download_and_extract 15:42:25 INFO - mkdir: /builds/slave/test/build/tests 15:42: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')]} 15:42:25 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json 15:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json 15:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:42:26 INFO - Downloaded 1149 bytes. 15:42:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:42:26 INFO - Using the following test package requirements: 15:42:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:42:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:42:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'jsshell-mac.zip'], 15:42:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:42:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:42:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:42:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:42:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:42:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:42:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:42:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:42:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:26 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:42:27 INFO - Downloaded 17522538 bytes. 15:42:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 15:42:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:42:30 INFO - Return code: 0 15:42:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:42: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')]} 15:42:30 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:42:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:42:36 INFO - Downloaded 17522538 bytes. 15:42:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 15:42:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:42:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:42:39 INFO - Return code: 0 15:42:39 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')]} 15:42:39 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:42:45 INFO - Downloaded 11130997 bytes. 15:42:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 15:42:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:42:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:42:45 INFO - Return code: 0 15:42:45 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')]} 15:42:45 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:42:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:42:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:42:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 15:42:49 INFO - Downloaded 109423896 bytes. 15:42:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:42:49 INFO - mkdir: /builds/slave/test/properties 15:42:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:49 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:49 INFO - Contents: 15:42:49 INFO - build_url:https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:42:49 INFO - Running post-action listener: _resource_record_post_action 15:42:49 INFO - Running post-action listener: set_extra_try_arguments 15:42:49 INFO - ##### 15:42:49 INFO - ##### Running populate-webroot step. 15:42:49 INFO - ##### 15:42:49 INFO - Running pre-action listener: _resource_record_pre_action 15:42:49 INFO - Running main action method: populate_webroot 15:42:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:42:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:42:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:42:49 INFO - '../fennec_ids.txt'], 15:42:49 INFO - 'tests': ['tcheck2']}, 15:42:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:42:49 INFO - '--tppagecycles', 15:42:49 INFO - '7'], 15:42:49 INFO - 'tests': ['tsvgm']}}, 15:42:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:42:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:42:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'tests': ['damp', 'tps']}, 15:42:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['damp', 'tps']}, 15:42:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:42:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:49 INFO - 'other': {'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'other_l64': {'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'other_nol64': {'tests': ['a11yr', 15:42:49 INFO - 'ts_paint', 15:42:49 INFO - 'tpaint', 15:42:49 INFO - 'sessionrestore', 15:42:49 INFO - 'sessionrestore_no_auto_restore']}, 15:42:49 INFO - 'svgr': {'tests': ['tsvgx', 15:42:49 INFO - 'tsvgr_opacity', 15:42:49 INFO - 'tart', 15:42:49 INFO - 'tscrollx', 15:42:49 INFO - 'cart']}, 15:42:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['tsvgx', 15:42:49 INFO - 'tsvgr_opacity', 15:42:49 INFO - 'tart', 15:42:49 INFO - 'tscrollx', 15:42:49 INFO - 'cart']}, 15:42:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'tests': ['tp5o']}, 15:42:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'talos_options': ['--e10s'], 15:42:49 INFO - 'tests': ['tp5o']}, 15:42:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'talos_options': ['--xperf_path', 15:42:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:49 INFO - 'tests': ['tp5n']}, 15:42:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:49 INFO - 'talos_options': ['--e10s', 15:42:49 INFO - '--xperf_path', 15:42:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:49 INFO - 'tests': ['tp5n']}}, 15:42:49 INFO - 'talos.zip': {'path': '', 15:42:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:42:49 INFO - Running post-action listener: _resource_record_post_action 15:42:49 INFO - ##### 15:42:49 INFO - ##### Running create-virtualenv step. 15:42:49 INFO - ##### 15:42:49 INFO - Running pre-action listener: _resource_record_pre_action 15:42:49 INFO - Running main action method: create_virtualenv 15:42:49 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:49 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 15:42:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:42:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:49 INFO - Using real prefix '/tools/python27' 15:42:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:52 INFO - Installing pip.................done. 15:42:52 INFO - Return code: 0 15:42:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42:52 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')]} 15:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:52 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')]} 15:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:52 INFO - 'HOME': '/Users/cltbld', 15:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:52 INFO - 'LOGNAME': 'cltbld', 15:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:52 INFO - 'MOZ_NO_REMOTE': '1', 15:42:52 INFO - 'NO_EM_RESTART': '1', 15:42:52 INFO - 'PAGER': '/bin/cat', 15:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:52 INFO - 'PWD': '/builds/slave/test', 15:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:52 INFO - 'SHELL': '/bin/bash', 15:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:42:52 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:52 INFO - 'USER': 'cltbld', 15:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:52 INFO - 'XPC_FLAGS': '0x0', 15:42:52 INFO - 'XPC_SERVICE_NAME': '0', 15:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:52 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 15:42:52 INFO - Cleaning up... 15:42:52 INFO - Return code: 0 15:42:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:42:52 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')]} 15:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:52 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')]} 15:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:52 INFO - 'HOME': '/Users/cltbld', 15:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:52 INFO - 'LOGNAME': 'cltbld', 15:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:52 INFO - 'MOZ_NO_REMOTE': '1', 15:42:52 INFO - 'NO_EM_RESTART': '1', 15:42:52 INFO - 'PAGER': '/bin/cat', 15:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:52 INFO - 'PWD': '/builds/slave/test', 15:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:52 INFO - 'SHELL': '/bin/bash', 15:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:42:52 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:52 INFO - 'USER': 'cltbld', 15:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:52 INFO - 'XPC_FLAGS': '0x0', 15:42:52 INFO - 'XPC_SERVICE_NAME': '0', 15:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:53 INFO - Downloading/unpacking psutil>=0.7.1 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 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 15:42:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:42:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:55 INFO - Installing collected packages: psutil 15:42:55 INFO - Running setup.py install for psutil 15:42:56 INFO - building 'psutil._psutil_osx' extension 15:42:56 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 15:42:56 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 15:42:56 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 15:42:56 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 15:42:56 INFO - building 'psutil._psutil_posix' extension 15:42:56 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 15:42:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:42:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:42:56 INFO - ^ 15:42:56 INFO - 1 warning generated. 15:42:56 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 15:42:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:56 INFO - Successfully installed psutil 15:42:56 INFO - Cleaning up... 15:42:56 INFO - Return code: 0 15:42:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:56 INFO - 'HOME': '/Users/cltbld', 15:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:56 INFO - 'LOGNAME': 'cltbld', 15:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:56 INFO - 'MOZ_NO_REMOTE': '1', 15:42:56 INFO - 'NO_EM_RESTART': '1', 15:42:56 INFO - 'PAGER': '/bin/cat', 15:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:56 INFO - 'PWD': '/builds/slave/test', 15:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:56 INFO - 'SHELL': '/bin/bash', 15:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:42:56 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:56 INFO - 'USER': 'cltbld', 15:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:56 INFO - 'XPC_FLAGS': '0x0', 15:42:56 INFO - 'XPC_SERVICE_NAME': '0', 15:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:42:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:42:59 INFO - Installing collected packages: mozsystemmonitor 15:42:59 INFO - Running setup.py install for mozsystemmonitor 15:42:59 INFO - Successfully installed mozsystemmonitor 15:42:59 INFO - Cleaning up... 15:42:59 INFO - Return code: 0 15:42:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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')]} 15:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:59 INFO - 'HOME': '/Users/cltbld', 15:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:59 INFO - 'LOGNAME': 'cltbld', 15:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:59 INFO - 'MOZ_NO_REMOTE': '1', 15:42:59 INFO - 'NO_EM_RESTART': '1', 15:42:59 INFO - 'PAGER': '/bin/cat', 15:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:59 INFO - 'PWD': '/builds/slave/test', 15:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:59 INFO - 'SHELL': '/bin/bash', 15:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:42:59 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:59 INFO - 'USER': 'cltbld', 15:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:59 INFO - 'XPC_FLAGS': '0x0', 15:42:59 INFO - 'XPC_SERVICE_NAME': '0', 15:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:03 INFO - Downloading docopt-0.6.1.tar.gz 15:43:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:03 INFO - Running setup.py install for blobuploader 15:43:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:03 INFO - Running setup.py install for requests 15:43:03 INFO - Running setup.py install for docopt 15:43:04 INFO - Successfully installed blobuploader requests docopt 15:43:04 INFO - Cleaning up... 15:43:04 INFO - Return code: 0 15:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 15:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:04 INFO - 'HOME': '/Users/cltbld', 15:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:04 INFO - 'LOGNAME': 'cltbld', 15:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:04 INFO - 'MOZ_NO_REMOTE': '1', 15:43:04 INFO - 'NO_EM_RESTART': '1', 15:43:04 INFO - 'PAGER': '/bin/cat', 15:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:04 INFO - 'PWD': '/builds/slave/test', 15:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:04 INFO - 'SHELL': '/bin/bash', 15:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:43:04 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:04 INFO - 'USER': 'cltbld', 15:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:04 INFO - 'XPC_FLAGS': '0x0', 15:43:04 INFO - 'XPC_SERVICE_NAME': '0', 15:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-1ItYDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-CYjE8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-87xGfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wcxE3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-oVj9EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:04 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-JIJ6aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-vGgTEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-58_xWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-irGzjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-T3wlZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-upcZHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wqEhZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-0TYG2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Z2iLrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-DBACUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-x8w2px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-9QtzEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:06 INFO - Running setup.py install for manifestparser 15:43:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Running setup.py install for mozcrash 15:43:06 INFO - Running setup.py install for mozdebug 15:43:06 INFO - Running setup.py install for mozdevice 15:43:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Running setup.py install for mozfile 15:43:07 INFO - Running setup.py install for mozhttpd 15:43:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Running setup.py install for mozinfo 15:43:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Running setup.py install for mozInstall 15:43:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Running setup.py install for mozleak 15:43:07 INFO - Running setup.py install for mozlog 15:43:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Running setup.py install for moznetwork 15:43:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:07 INFO - Running setup.py install for mozprocess 15:43:08 INFO - Running setup.py install for mozprofile 15:43:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:08 INFO - Running setup.py install for mozrunner 15:43:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:08 INFO - Running setup.py install for mozscreenshot 15:43:08 INFO - Running setup.py install for moztest 15:43:08 INFO - Running setup.py install for mozversion 15:43:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:08 INFO - Cleaning up... 15:43:08 INFO - Return code: 0 15:43:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:08 INFO - 'HOME': '/Users/cltbld', 15:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:08 INFO - 'LOGNAME': 'cltbld', 15:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:08 INFO - 'MOZ_NO_REMOTE': '1', 15:43:08 INFO - 'NO_EM_RESTART': '1', 15:43:08 INFO - 'PAGER': '/bin/cat', 15:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:08 INFO - 'PWD': '/builds/slave/test', 15:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:08 INFO - 'SHELL': '/bin/bash', 15:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:43:08 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:08 INFO - 'USER': 'cltbld', 15:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:08 INFO - 'XPC_FLAGS': '0x0', 15:43:08 INFO - 'XPC_SERVICE_NAME': '0', 15:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Gfj0Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:09 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)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-A9S5Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-hW7AI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:09 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)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-eHpYrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-RDWkls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-IKf3sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3wcHCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-iVt4SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:09 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-YiOyk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:10 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)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-5P2L3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-WQdlGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:10 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)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Toq2K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:10 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)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-hCcZc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-153YNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-1W9lae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-EGZPC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-KHriby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:43:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - Downloading blessings-1.5.1.tar.gz 15:43:13 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:13 INFO - Installing collected packages: blessings 15:43:13 INFO - Running setup.py install for blessings 15:43:13 INFO - Successfully installed blessings 15:43:13 INFO - Cleaning up... 15:43:13 INFO - Return code: 0 15:43:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:13 INFO - Reading from file tmpfile_stdout 15:43:13 INFO - Current package versions: 15:43:13 INFO - blessings == 1.5.1 15:43:13 INFO - blobuploader == 1.2.4 15:43:13 INFO - docopt == 0.6.1 15:43:13 INFO - manifestparser == 1.1 15:43:13 INFO - mozInstall == 1.12 15:43:13 INFO - mozcrash == 0.16 15:43:13 INFO - mozdebug == 0.1 15:43:13 INFO - mozdevice == 0.47 15:43:13 INFO - mozfile == 1.2 15:43:13 INFO - mozhttpd == 0.7 15:43:13 INFO - mozinfo == 0.9 15:43:13 INFO - mozleak == 0.1 15:43:13 INFO - mozlog == 3.0 15:43:13 INFO - moznetwork == 0.27 15:43:13 INFO - mozprocess == 0.22 15:43:13 INFO - mozprofile == 0.27 15:43:13 INFO - mozrunner == 6.11 15:43:13 INFO - mozscreenshot == 0.1 15:43:13 INFO - mozsystemmonitor == 0.0 15:43:13 INFO - moztest == 0.7 15:43:13 INFO - mozversion == 1.4 15:43:13 INFO - psutil == 3.1.1 15:43:13 INFO - requests == 1.2.3 15:43:13 INFO - wsgiref == 0.1.2 15:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x103354490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103331228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449c60340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, '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.wueuXMmB0x/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.5ykQIguPB8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 15:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 15:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 15:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:13 INFO - 'HOME': '/Users/cltbld', 15:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:13 INFO - 'LOGNAME': 'cltbld', 15:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:13 INFO - 'MOZ_NO_REMOTE': '1', 15:43:13 INFO - 'NO_EM_RESTART': '1', 15:43:13 INFO - 'PAGER': '/bin/cat', 15:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:13 INFO - 'PWD': '/builds/slave/test', 15:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:13 INFO - 'SHELL': '/bin/bash', 15:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:43:13 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:13 INFO - 'USER': 'cltbld', 15:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:13 INFO - 'XPC_FLAGS': '0x0', 15:43:13 INFO - 'XPC_SERVICE_NAME': '0', 15:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:43:13 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:13 INFO - Cleaning up... 15:43:13 INFO - Return code: 0 15:43:13 INFO - Running post-action listener: _resource_record_post_action 15:43:13 INFO - Running post-action listener: _start_resource_monitoring 15:43:13 INFO - Starting resource monitoring. 15:43:13 INFO - ##### 15:43:13 INFO - ##### Running install step. 15:43:13 INFO - ##### 15:43:13 INFO - Running pre-action listener: _resource_record_pre_action 15:43:13 INFO - Running main action method: install 15:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:14 INFO - Reading from file tmpfile_stdout 15:43:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:14 INFO - Reading from file tmpfile_stdout 15:43:14 INFO - Output received: 15:43:14 INFO - Usage: mozinstall [options] installer 15:43:14 INFO - Options: 15:43:14 INFO - -h, --help show this help message and exit 15:43:14 INFO - -d DEST, --destination=DEST 15:43:14 INFO - Directory to install application into. [default: 15:43:14 INFO - "/builds/slave/test"] 15:43:14 INFO - --app=APP Application being installed. [default: firefox] 15:43:14 INFO - mkdir: /builds/slave/test/build/application 15:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:43:44 INFO - Reading from file tmpfile_stdout 15:43:44 INFO - Output received: 15:43:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:43:44 INFO - Running post-action listener: _resource_record_post_action 15:43:44 INFO - ##### 15:43:44 INFO - ##### Running run-tests step. 15:43:44 INFO - ##### 15:43:44 INFO - Running pre-action listener: _resource_record_pre_action 15:43:44 INFO - Running main action method: run_tests 15:43:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:44 INFO - 2015-11-19 15:43:44.596 screenresolution[2537:22616] starting screenresolution argv=screenresolution get 15:43:44 INFO - 2015-11-19 15:43:44.598 screenresolution[2537:22616] Display 0: 1600x1200x32@60 15:43:44 INFO - 2015-11-19 15:43:44.603 screenresolution[2538:22618] starting screenresolution argv=screenresolution list 15:43:44 INFO - Available Modes on Display 0 15:43:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:44 INFO - Intel Iris: 15:43:44 INFO - Chipset Model: Intel Iris 15:43:44 INFO - Type: GPU 15:43:44 INFO - Bus: Built-In 15:43:44 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:44 INFO - Vendor: Intel (0x8086) 15:43:44 INFO - Device ID: 0x0a2e 15:43:44 INFO - Revision ID: 0x0009 15:43:44 INFO - Displays: 15:43:44 INFO - Display: 15:43:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:44 INFO - Display Serial Number: 1600x1200 60 15:43:44 INFO - Main Display: Yes 15:43:44 INFO - Mirror: Off 15:43:44 INFO - Online: Yes 15:43:44 INFO - Rotation: Supported 15:43:44 INFO - Return code: 0 15:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:44 INFO - Python 2.7.3 15:43:44 INFO - Return code: 0 15:43:44 INFO - grabbing minidump binary from tooltool 15:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:44 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 0x1032789f0>, '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 0x102fd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:44 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 15:43:44 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 15:43:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:44 INFO - Return code: 0 15:43:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:43:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:43:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost'] in /builds/slave/test/build 15:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --webServer localhost 15:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wueuXMmB0x/Render', 15:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:44 INFO - 'HOME': '/Users/cltbld', 15:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:44 INFO - 'LOGNAME': 'cltbld', 15:43:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:44 INFO - 'MOZ_NO_REMOTE': '1', 15:43:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:44 INFO - 'NO_EM_RESTART': '1', 15:43:44 INFO - 'PAGER': '/bin/cat', 15:43:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:44 INFO - 'PWD': '/builds/slave/test', 15:43:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:44 INFO - 'SHELL': '/bin/bash', 15:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5ykQIguPB8/Listeners', 15:43:44 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 15:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:44 INFO - 'USER': 'cltbld', 15:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:44 INFO - 'XPC_FLAGS': '0x0', 15:43:44 INFO - 'XPC_SERVICE_NAME': '0', 15:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost'] with output_timeout 3600 15:43:45 INFO - mozversion INFO | application_buildid: 20151119131711 15:43:45 INFO - mozversion INFO | application_changeset: a76322320837ac6d0c9510c280706359a47ea309 15:43:45 INFO - mozversion INFO | application_display_name: Nightly 15:43:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:45 INFO - mozversion INFO | application_name: Firefox 15:43:45 INFO - mozversion INFO | application_remotingname: firefox 15:43:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:43:45 INFO - mozversion INFO | application_vendor: Mozilla 15:43:45 INFO - mozversion INFO | application_version: 45.0a1 15:43:45 INFO - mozversion INFO | platform_buildid: 20151119131711 15:43:45 INFO - mozversion INFO | platform_changeset: a76322320837ac6d0c9510c280706359a47ea309 15:43:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:43:45 INFO - mozversion INFO | platform_version: 45.0a1 15:43:45 INFO - 2015-11-19 15:43:45,132 DEBUG : using testdate: 1447976625 15:43:45 INFO - 2015-11-19 15:43:45,132 DEBUG : actual date: 1447976625 15:43:45 INFO - 2015-11-19 15:43:45,141 INFO : starting webserver on 'localhost:50405' 15:43:45 INFO - 2015-11-19 15:43:45,142 INFO : Starting test suite t-yosemite-r7-0045.e 15:43:45 INFO - 2015-11-19 15:43:45,142 INFO : Starting test dromaeo_css 15:43:45 INFO - 2015-11-19 15:43:45,142 DEBUG : operating with platform_type : mac_ 15:43:45 INFO - 2015-11-19 15:43:45,143 INFO : Initialising browser for dromaeo_css test... 15:43:45 INFO - 2015-11-19 15:43:45,155 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp1CMWiV/profile http://localhost:50405/getInfo.html 15:43:47 INFO - 2015-11-19 15:43:47,825 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:43:47 INFO - 2015-11-19 15:43:47,825 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:43:47 INFO - 2015-11-19 15:43:47,825 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:43:47 INFO - 2015-11-19 15:43:47,825 DEBUG : BROWSER_OUTPUT: __metrics 15:43:48 INFO - 2015-11-19 15:43:48,434 INFO : Browser initialized. 15:43:48 INFO - 2015-11-19 15:43:48,435 INFO : Running cycle 1/1 for dromaeo_css test... 15:43:48 INFO - 2015-11-19 15:43:48,435 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp1CMWiV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:44:00 INFO - 2015-11-19 15:44:00,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 237326336 15:44:00 INFO - 2015-11-19 15:44:00,376 DEBUG : BROWSER_OUTPUT: 15:44:50 INFO - 2015-11-19 15:44:50,039 DEBUG : BROWSER_OUTPUT: 1447976690038 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] 15:47:00 INFO - 2015-11-19 15:47:00,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50405/tests/dromaeo/cssquery-ext.html) 15:47:01 INFO - 2015-11-19 15:47:01,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 253079552 15:47:01 INFO - 2015-11-19 15:47:01,939 DEBUG : BROWSER_OUTPUT: 15:50:04 INFO - 2015-11-19 15:50:04,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-ext.html (next: http://localhost:50405/tests/dromaeo/cssquery-jquery.html) 15:50:04 INFO - 2015-11-19 15:50:04,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 262930432 15:50:04 INFO - 2015-11-19 15:50:04,593 DEBUG : BROWSER_OUTPUT: 15:53:06 INFO - 2015-11-19 15:53:06,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50405/tests/dromaeo/cssquery-mootools.html) 15:53:06 INFO - 2015-11-19 15:53:06,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 264503296 15:53:06 INFO - 2015-11-19 15:53:06,837 DEBUG : BROWSER_OUTPUT: 15:56:08 INFO - 2015-11-19 15:56:08,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50405/tests/dromaeo/cssquery-prototype.html) 15:56:09 INFO - 2015-11-19 15:56:09,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 265842688 15:56:09 INFO - 2015-11-19 15:56:09,045 DEBUG : BROWSER_OUTPUT: 15:59:11 INFO - 2015-11-19 15:59:11,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50405/tests/dromaeo/cssquery-yui.html) 15:59:12 INFO - 2015-11-19 15:59:12,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 268988416 15:59:12 INFO - 2015-11-19 15:59:12,050 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/dromaeo/cssquery-yui.html (next: http://localhost:50405/tests/dromaeo/cssquery-dojo.html) 16:02:14 INFO - 2015-11-19 16:02:14,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 272367616 16:02:14 INFO - 2015-11-19 16:02:14,725 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,725 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:02:14 INFO - 2015-11-19 16:02:14,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:02:14 INFO - 2015-11-19 16:02:14,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:02:14 INFO - 2015-11-19 16:02:14,726 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:02:14 INFO - 2015-11-19 16:02:14,727 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3468.9479657805127;3549.94675079874;3565.9108522286924;3584.2473080653062;3591.5690117185927;5880.794172203974;5919.082542205954;5925.437083477068;5955.553333499983;5963.314218864832;5720.771169153229;5892.322382925965;5897.115432685099;5921.467067963882;5989.490893274077;5298.549623282016;5329.467053294678;5344.4922732340365;5386.272853164812;5411.512963833255;944.403328389833;5318.946810531884;5347.491988261109;5354.973225133869;5447.782088716466;5312.946870531284;5321.148616221425;5337.866553336159;5341.145416733323;5358.571314294847;5329.626926115174;5331.840044798662;5342.305500284977;5387.73061346935;5408.161734931092;5090.490950904917;5108.719020453874;5211.088059589557;5270.288511050997;5302.655327403706;4870.293807397908;5419.674819510803;5694.886102277973;5756.395578464243;5855.092460668603;6326.810195694136;6348.555601107924;6352.333005034498;6360.968195158995;6368.681565921732;6211;6311.779087731908;6319.273283572356;6460.547761656686;6467.870642587169;4343.718603012119;4997.375328083989;5553.694881702797;5563.693996830173;6101.115338275925;6314.778982735582;6494.9350506495275;6509.8698026040165;6539.346065393518;6560.081588577603;6118.558266176196;6159.784407545714;6257.7184026718905;6285.842853928689;6299.181106456132;4633.675642704979;6339.651319177489;6415.26224484181;6415.903761443582;6418.711157997808;6109.617229398918;6231.844203894848;6289.465395441439;6345.714442850082;6367.936320636827;6176.7838125666285;6263.123162757218;6296.496280297565;6306.558540902093;6315.210598675166;5066.36670416198;5068.138416469209;5069.518395752398;5084.669496482717;5107.361579802525;4416;4458.08609235106;4508.661850361171;4586.289125185602;4600.5169457207185;6028.969855150784;6046;6067.75728970845;6095.542834287447;6137.232845894263;6347.809565713036;6386.744530218739;6419.967900160469;6426.646534440557;6427.517936154713;5889.234399528034;6068.150458935753;6071.0286354184;6074.453299203093;6170.629762214281;5563.5271001964475;5573.247611572467;5577.330720313507;5578.693171875586;5578.9163162552595;5867.70661466925;6353.30113687494;6598.142241508669;6598.901016484852;6605.801825945326;6113.445900579521;6198.504119670506;6255.374462553708;6298.84252893663;6312.305646378986;6523.902141467976;6538.574992625464;6565.606063636197;6576.638284894377;6586.37429444202;6145.354737752472;6358.650274234961;6388.361163883575;6391.840203994937;6402.327755585783;6226.128342032029;6313.2424109107205;6344.809655710336;6348.396902294275;6350.142730731292;6292.150559674568;6303.432691057827;6305.148804911461;6306.243250809932;6334;6096.420840020191;6132.754689812357;6193.752249909953;6309.274433440213;6322.367763223825;6097.282711137887;6215.160953271251;6227.252729672287;6249.0626406039455;6288.905666414916;5620.887582248414;6286.717097730521;6301.991681330965;6306.590071645328;6336;4913.557779799835;6006.369331220334;6069.696515174312;6211.9068213975925;6261.436470717657 16:02:14 INFO - 2015-11-19 16:02:14,731 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.3138014721304;551.1952549278054;589.8407429993902;590.1236663554623;619.5632079384034;40828;41340.96647583812;41515.377269340985;41552.79223603882;41562.58437415625;45266.321005184946;45459.77270113653;45523.63429097124;45658.543414565844;45664.54335456644;9764.072413120743;9866.112049915506;9899.059589339036;9962.850557241647;9981.251406144533;9693.515324233795;9729.756756081119;9802.950985245065;9819.656312029081;9824.901750982506;9735.221182305399;9767.97436269192;9847.950760246189;9878.2591305652;9896.851547226797;8450.830983380298;9749.26880483963;9862.60549578016;9877.506124693737;9881.16010139139;9647.276454265888;9734.36726612768;9751.951240243825;9792.21662267017;9828.115469607697;34433.13917152066;41096.38355424671;41298;41321.793391033156;41565.376519352234;2802.817816841919;3187.9203019924457;3235.4823228283362;3360.2607426366403;3422.709069729051;28347.149585512263;29275.707242927725;29300.974465893592;29354;29425.411491770046;2800.7339302766204;2819.2247132038647;2821.9435611287863;2877.223149749577;2958.1421387797513;456266;459617.70191149163;461101;461574;463527.682361586;59435.702821486484;60436.697816510634;69313;70924;70956.64521677462;66838;67715.32284677189;67972.98040529396;68223.65888170627;68925;16561.00633961966;16730.4144354947;16783.91608041952;16803;16933.830661693224;12600.054995875345;12724.172928759786;12742.68143296425;12789.360531973363;12830.67923301925;20016.69974950377;20038.398848034583;20188.798112018692;20328;20335.694964575545;8644.524551149621;8688.261497772633;8699.478031318014;8708.69519566812;8801.987771406242;942.8020115775764;943.4480828715141;966.1787480641539;1081.4862940103544;1096.0738176241064;23152;29583;29896;30332.54501182484;30528.694713053028;1052.5421441672897;1137.135776809614;1142.3774043146504;1180.8760080191628;1189.7620475904853;14741.705165896621;15916.363345466283;15992.92003539998;16109.758353624706;16229.2696828643;520540;523449;529348;530218;532294;59530;60122.39877601168;60407.69796150991;60705.69647151736;60828.391716082275;1278.3161008860402;1284.1973766396002;1421.3106643278002;1427.750143724844;1442.9422823087168;30139.69860301369;30289.545656814724;30381.848090759406;30499.695003050572;30718.692813071582;50946.49053509418;51333.743331283105;51358;51680.74159629178;51716.638418502676;507495;509965;513385;514291;516148;31076.446177691476;33424.83287583546;33445.83277083599;34026.489602655485;34203.828980855935;34417.82791086029;42650.57349426466;43178.35232471453;43246;43689.344659830764;35075.649243507236;36210.637893620726;36818.63181368152;36852.81573592115;37241.510339586115;35381.46927796137;36064;36089.81955090208;36237.45643815292;36496.08759781027;34840.82579587086;35516;35741.927742167776;35906.10234744152;36045;30154.09537713872;31707;31794.84102579472;31882.36235275328;32117;23845.04619815188;24120.276391708278;24329.635055473827;24434.022639094237;25143.87428062921 16:02:14 INFO - 2015-11-19 16:02:14,732 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.6637960317303;361.353177811717;364.01715368505035;364.26418634358595;365.4755425963744;15423.641309743633;19790.70313945292;19853.503662408446;20313.695294570574;20909.47726306843;21066.683999740017;21267.893660531674;21324.786752132473;21394.14423423061;21494.89252553735;6551.213854337474;6730.596164230137;6733.225679046924;6736.124303840494;6737.562058466208;5001.724905130216;6721.731130754764;7596.6581503832185;7613.505122167069;7623.161452240249;7361.4846960712775;7521.398288136936;7546.2076481969425;7580.507267027653;7602.429817763662;7438.181800001996;7456.888146677804;7458.701651933916;7471.887921681179;7499.625018749068;6233.501319894398;7002.964985175042;7043.295670432967;7154.069970903801;7212.7114915403845;24700.505989880283;24840.627390589154;25298.620520692206;26764.866175668998;26804.73195268042;2138.422625891016;2149.7850214978534;2184.2194378597947;2190.6385446401323;2354.85870847748;12429.689257768538;15532.534023979299;15545.222738863125;15615.375384984587;15792.842071579253;1579.8657114145312;1920.9711854322197;1934.8935808530525;1952.4142757172933;1991.800819918011;107675.46162269216;111943.88056119416;113439.43280283628;114167.42916285449;114796;18765.812341876408;18832.964186969573;19172.328968486316;19227.711584326247;19267.710984335245;22826.17390608747;26850.462990740467;27479.450410992067;28106.437871242462;28206;9492.050794920591;10450.843237351446;10458.320209186379;10540.262181647364;10542.631007914686;8087.191280871866;8792.208701216921;8887.955560222286;8948.8657670135;8956.193942545202;4262.147570485915;4263.062126332264;8509.872351914726;8701.825963480822;8728.389012769045;1861.4043506078197;1883.8304552590332;1889.5842914558775;1901.4390754727388;1930.9903450482939;731.9240716147254;855.2260204514924;925.1396201532639;931.6366617019368;1005.4319309590059;11625.767484650429;11885.762284754257;11901.761964760657;11918.52325906954;20829.89585052065;420.26453706014473;428.4066567803552;438.0428763152522;443.87349605362965;452.470609387018;11402.20184587071;11811.527538898348;11883.64349069512;11944.402779860971;11958.804119588145;619685;713832.4308378529;751181;775016.1249193718;782525;129898.35050824874;130172.69827301796;130235;130566.69433305736;133492;479.4701854450851;484.5033840313707;486.69338316860154;487.14749188919393;487.4467479410894;11211.215214934877;11307.547698092314;11367.48846301935;11479.655610331703;11486.966173044466;33853;46306.07387852291;53122.73438632782;53875;54875.451245487035;72005.6399717998;73242.63378683286;73297.26702732904;74104.25895741189;76903.61548192223;9738.80522389534;9790.608375664893;10082.596696132367;10098.283291840258;10162.18702503783;19523.414297571097;19768.505787355432;19978.800211997695;20187.0915808786;20274.391768246976;15782.36870525212;16037.518874433787;16129.838701612834;16327.510174694778;16479.91760041192;12926.224426534438;14049.508267210598;14542.054766440571;15432.2283885803;15589.922050389676;16189.190540473164;16191.433299834449;16320.265588048804;16625.50123496297;16718.33126674968;9931.056549627774;9946.651867184613;9955.701328960144;10053.246006549392;10073.294869359075;10406.687799366031;14544.709105817612;16477.83522164763;16497.505074847773;16968.49094527166 16:02:14 INFO - 2015-11-19 16:02:14,733 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.632648164441;1573.6380632454536;1899.5441094137407;1909.2267631609186;1916.5687720262943;7291.234420385849;7369.963150184255;8350.206730360622;8468.915310846889;8505.447145935517;8185.959070204655;8240.340772738182;8302.833943321146;8315.875261871077;8355.415120941536;2365.349528879555;2391.330427480308;2394.832361734679;2403.807695384374;2408.903643854244;2403.9639405408934;2427.817913656474;2439.512097580482;2446.779789818916;2451.44842410458;2236.049678886475;2251.3921241264848;2287.531056133497;2288.3135059482174;2289.919852805152;2000.9699854502194;2325.4186453386656;2373.8338316317863;2374.4182675244588;2378.2270762002245;2378.120095564635;2382.559226543095;2389.9522009559887;2407.5064611754547;2425;8314.542700151489;8392.706255281097;8397.790055248606;8439.156084391572;8478;4527.3435351873795;5075.543201111917;5193.740312984373;5208.5572726318305;5213.582913366921;3158.4472717274384;3443.345764304774;3446.913827154341;3520.894373168809;3595.334863050318;1027.5786927359748;1048;1053.0838170791385;1083.2254937719567;1084.046039485248;10000.94999525005;10248.923862994427;11078.556857725762;11080.944595277053;11091.001809837073;4314.770290467264;4362.476502819682;4690.882727931829;4805.038992201574;4819.012102518976;9586.760330991641;9592;9597.328187026842;9605.47169905648;9641.758956026155;5183.248428977777;5197.272381866542;5237.476252374732;5257.658252213594;5264.0261551613075;4681.133990211822;4760.785764640599;4787.066522028241;4793.520647935178;4801.831935882297;3902.512185976753;3903.1217975955183;3916.8824935251987;3924.1170736584613;3929.7445666031617;1279.584135156078;1284.3321472834075;1293.5213970830853;1294.5792617399384;1299.408769010117;1146.6560031990537;1147.529512899707;1154.9018333441752;1158.5134243617701;1163.668354518958;7832.295093441618;7947.9205207948335;7960.761177164694;7983.920160798434;8004.879926801103;1025.041586116983;1140.8916152965455;1186.347508870118;1209.2683926224684;1224.455117472716;5863.677497737665;6189.164462797555;6256.217972753406;6273.0904018917;6278.968605156945;9038.593263303035;10247.38515689061;10274.383536987805;10332.845007324897;10356.482175891175;9760.755981100529;9876.753081173028;10107;10107.797844043225;10190.796184076276;6723.562968407038;7837;7892.526448413114;7922.286994170552;7942.44402891792;7693.92285080078;7826.2173782621285;7831.569263690551;7896.32881205104;7922.960385198037;8853.557322133996;8975.640974360953;9042.63829446841;9088.727338179866;9093.22707569864;9164.358494905293;9243.260539156718;9274;9462.101100395452;9480.525973701426;7310.926890731024;7329.890051649123;7401.851962960603;7403.925960740324;7406.740764073232;7982.241687039722;8012.198780121941;8038.598070096355;8075.596220189084;8079.919200807916;7488.138864030706;7508.399328053852;7519;7620.237976202336;7652.196519365609;7377.077865266841;7407.111146662435;7450.8882366763455;7453.478256521991;7493.662785174572;7432.368248698921;7466.290702383265;7508.699652013858;7517.02278703765;7550.3582195514;6825.078614387193;6841.726330946706;6892.276310987274;6896.931030689629;6908.171019477695;6829.692663830239;6848.280930502226;6949.166100067822;6950.374466298057;6959.965200173967 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.6717680788787;322.69505317474983;325.175679652082;326.4026830899454;333.08900158067695;6613.867722645544;6813.761518346859;6871.622060786654;6882.552634078781;6974.128233970754;5353.973230133844;5663.546916246701;6613.867722645544;6686.130802995616;6766.695498702558;4076.51081870176;4968.677035992649;5095.6178286628465;5118.692878427288;5126.948730512684;4116.34138537834;5081;5099;5099.9235011474675;5100.923486147711;4827.8551643450755;5020.924686129711;5042.319286896277;5047.596192304607;5056.797728090872;4996.725180115092;5005.399352077738;5009.198528235464;5035.320231768701;5041.521055499722;4093.8771836844944;4207.747535147871;4215.536291007987;4301.978490107561;4308.504521979981;6521.706523206467;6567.770128045496;6586.769463068769;6605.669716514203;6624.238212605564;5903.114532820068;5905.114232865061;5915.112733090028;5926.97036514819;5947.92937271291;7078.32755888195;7266.600336981464;7289.307515785992;7317.926820731778;7329.120505539369;4833.830815921461;4854.611631069506;4855.757212139414;4863.392075990501;4871.171900776876;7697.230276972314;7793.298603125802;7840.843183136362;7846.882296765553;7852.21477852216;4814.542618451242;4930.359053323045;4931.18635425158;4939.876503087452;4958.107540642719;5048.419431765394;5051.621128415383;5056.797728090835;5073.720945348041;5078.923816142761;4770.666053376231;5912.083627037816;5974.103884417285;5980.970095149496;6017.428344307284;5925.911111333334;7382.114146302478;7390.96304518474;7403.777886663409;7412.555246685216;1711.238498867992;1743.747156662277;1747.1700942052423;1749.860011199101;1752.6932786762266;1111.6720567432626;1115.4590023838593;1126.1328776841785;1127.5489804078434;1135.8977692007759;5984.192134061933;6891.27641597635;6909.309069093151;6936.271691472423;6963.82590435233;7561.7731468056045;7615.162332143571;7648.923510764821;7653.579053152019;7660.923390766021;6781.220159681699;6875.656217189121;6890.276520965226;6969.6166710830375;7056.400205982549;3349.949750753741;4004.379321205218;4010.1779135277197;4074.898127546776;4114.691398145092;8011.599420028975;8020.077691065486;8020.318272946864;8059.919400806034;8085.595720213966;7957;7978.3218426434405;7992.560409177551;8000.239977202156;8002.839943201104;7531.472796904273;7724.648186567329;7773.805654858561;8006.919930800617;8052.396070294752;7712.38300935935;7721.691132354643;7745.573993430416;7752.26353496417;7889.250521200477;7317.926820731725;7533.39732821362;7536.886946695694;7557.5465472071855;7585.393168546613;7985.760427187193;8001.679932802623;8004.83990320202;8011.078725946591;8020.278174964281;4743.217369134054;4779.402574678165;4783.330333753347;4784.736839473862;4802.303665968485;7403.296686814744;7644.503107298008;7671.61641917913;7678.654460549177;7687.077550693953;5878.500327472213;5960.254968128984;6324.841878953063;7348.448866335153;7374.151972523228;5958.136070269873;6606.009098635243;6680.665966701743;7057.8707406814665;7354.485186036926;5889.882202355843;6904.895216765293;7193.136823581203;7225.5664660120565;7259.2377800332315;7364.116306043309;7380.261973802577;7402.407807375289;7409.999650047174;7432.814179645336;7077.504574679723;7179.282071792779;7217.025701530226;7245.130584329914;7303.014093097364 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: |5;yui.html;616.3497510126816;715.7280233511267;764.7667461424263;789.6288744290182;854.8162145138793;14917.701645967074;14989.5503134906;15307.846921530781;15318.617034574127;16930.661386772288;15622.921885390586;15760.605984850385;15767.211639418041;15768.76346854798;15821.841781582181;940.1350757303263;949.3354651743772;957.707899090777;960.7886265021684;967.2358836519142;955.5126885288519;955.6177528988391;963.498980530124;973.2797729680057;975.8389865672191;1002.5338217728792;1005.9144972677332;1008.8638033865444;1011.1152741351318;1014.2747935226312;980.8283550378655;994.1897353656783;1007.531497853498;1008.6973907827622;1018.0684673523717;720.3768740039881;722.5520177489938;727.2545640718254;732.0848938826467;732.6153769271122;12561.56034538796;15193.392264309414;15344.846551534565;15349.155796431192;15361.769573456408;11483.540658373655;12468.563600274038;12560.057995650362;12660.39776153247;13148.01389895752;10307.536160872778;10489.842652360221;10558.155347572252;10575.629852955186;10820.891791082067;3471.5139880416764;3533.840977156034;3537.6108628050893;3597.3165098631175;3725.105974566112;69729;70702.64648676723;71692.64153679251;83151.5842420784;84080.57959710223;9297.209737172281;9507.429554226768;9609.519524023772;9685.806283874283;10044.447555384379;20311.390658280274;20798.27206047781;21029.263975760776;21112.577748444946;21244;7160.248173941765;7180.425565954711;7405.111386633531;7442.925570744332;7524.021877156044;4145.54399016108;4176.352665336878;4180.979095104505;4228.873133805991;4255.361695745601;2993.9550906736417;3575.12409459684;3599.7300202484917;3607.2244467439627;3625.184333524936;661.7121552124842;662.6322391073;663.2339647706906;670.1723371636026;672.9871543327359;491.3244289102484;503.29036059157147;514.1413838889064;514.4752352600327;544.4963408846801;8448.662053517914;8803.251723603566;8810.911890881138;8824.647014119364;9018.23345015681;593.7921727395463;619.5198720991268;628.7516431009817;630.0527197110109;635.9506813757245;3956.940645890314;4327.502337231259;4400.22995975703;4416.028473735773;4504.977475112603;94191.52904235572;95551.52224238974;97723;97833;98162;78253.60873195711;79882.80175797251;82102.58948705219;83025;86947.69578456329;75186.62406688041;75298;75916.62041689867;75965.86051209236;77160.61419692865;7458.291462311072;9036.05121462237;9082.318826087938;9105.043970383014;9224.308176886627;54206.728966354916;54225;54295.64260893509;54503.45496545143;55112.44887551073;47678.708916197706;76489.61755191188;77361.06597335111;77549.2245077542;78166;10981.341119532854;11084.833727493933;11118.388488633203;11608.767824643628;11662;11883.76232475363;12493.312867792358;12522.060845436446;12826.294553799258;12896.935515322364;11124.777504450027;11878.406079696153;11966.700832479257;11992.520299187934;12363.75272494527;11274.830877536679;11524.423778811193;11816.113791465847;11888.702782430508;12444;8275.234768180344;10991.06575941054;11273.098152147972;11491.482883270106;12435.440405181607;9419.29085048351;9508.809823803347;9733.367331123454;9762.75593110178;9770.951145244228;9172.174504294646;9188.570749320092;9324.440533568008;9843.753906152404;9956.352837065568 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,321 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: __startTimestamp1447977734724__endTimestamp 16:02:14 INFO - 2015-11-19 16:02:14,738 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,739 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:02:14 INFO - 2015-11-19 16:02:14,739 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:02:14 INFO - 2015-11-19 16:02:14,739 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,739 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5826.43 Median:6118.56 stddev:773.37 (12.6%) stddev-sans-first:753.30 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: Values: 3468.9 3549.9 3565.9 3584.2 3591.6 5880.8 5919.1 5925.4 5955.6 5963.3 5720.8 5892.3 5897.1 5921.5 5989.5 5298.5 5329.5 5344.5 5386.3 5411.5 944.4 5318.9 5347.5 5355.0 5447.8 5312.9 5321.1 5337.9 5341.1 5358.6 5329.6 5331.8 5342.3 5387.7 5408.2 5090.5 5108.7 5211.1 5270.3 5302.7 4870.3 5419.7 5694.9 5756.4 5855.1 6326.8 6348.6 6352.3 6361.0 6368.7 6211.0 6311.8 6319.3 6460.5 6467.9 4343.7 4997.4 5553.7 5563.7 6101.1 6314.8 6494.9 6509.9 6539.3 6560.1 6118.6 6159.8 6257.7 6285.8 6299.2 4633.7 6339.7 6415.3 6415.9 6418.7 6109.6 6231.8 6289.5 6345.7 6367.9 6176.8 6263.1 6296.5 6306.6 6315.2 5066.4 5068.1 5069.5 5084.7 5107.4 4416.0 4458.1 4508.7 4586.3 4600.5 6029.0 6046.0 6067.8 6095.5 6137.2 6347.8 6386.7 6420.0 6426.6 6427.5 5889.2 6068.2 6071.0 6074.5 6170.6 5563.5 5573.2 5577.3 5578.7 5578.9 5867.7 6353.3 6598.1 6598.9 6605.8 6113.4 6198.5 6255.4 6298.8 6312.3 6523.9 6538.6 6565.6 6576.6 6586.4 6145.4 6358.7 6388.4 6391.8 6402.3 6226.1 6313.2 6344.8 6348.4 6350.1 6292.2 6303.4 6305.1 6306.2 6334.0 6096.4 6132.8 6193.8 6309.3 6322.4 6097.3 6215.2 6227.3 6249.1 6288.9 5620.9 6286.7 6302.0 6306.6 6336.0 4913.6 6006.4 6069.7 6211.9 6261.4 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64794.77 Median:41197.19 stddev:133128.33 (323.1%) stddev-sans-first:133414.38 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: Values: 540.3 551.2 589.8 590.1 619.6 40828.0 41341.0 41515.4 41552.8 41562.6 45266.3 45459.8 45523.6 45658.5 45664.5 9764.1 9866.1 9899.1 9962.9 9981.3 9693.5 9729.8 9803.0 9819.7 9824.9 9735.2 9768.0 9848.0 9878.3 9896.9 8450.8 9749.3 9862.6 9877.5 9881.2 9647.3 9734.4 9752.0 9792.2 9828.1 34433.1 41096.4 41298.0 41321.8 41565.4 2802.8 3187.9 3235.5 3360.3 3422.7 28347.1 29275.7 29301.0 29354.0 29425.4 2800.7 2819.2 2821.9 2877.2 2958.1 456266.0 459617.7 461101.0 461574.0 463527.7 59435.7 60436.7 69313.0 70924.0 70956.6 66838.0 67715.3 67973.0 68223.7 68925.0 16561.0 16730.4 16783.9 16803.0 16933.8 12600.1 12724.2 12742.7 12789.4 12830.7 20016.7 20038.4 20188.8 20328.0 20335.7 8644.5 8688.3 8699.5 8708.7 8802.0 942.8 943.4 966.2 1081.5 1096.1 23152.0 29583.0 29896.0 30332.5 30528.7 1052.5 1137.1 1142.4 1180.9 1189.8 14741.7 15916.4 15992.9 16109.8 16229.3 520540.0 523449.0 529348.0 530218.0 532294.0 59530.0 60122.4 60407.7 60705.7 60828.4 1278.3 1284.2 1421.3 1427.8 1442.9 30139.7 30289.5 30381.8 30499.7 30718.7 50946.5 51333.7 51358.0 51680.7 51716.6 507495.0 509965.0 513385.0 514291.0 516148.0 31076.4 33424.8 33445.8 34026.5 34203.8 34417.8 42650.6 43178.4 43246.0 43689.3 35075.6 36210.6 36818.6 36852.8 37241.5 35381.5 36064.0 36089.8 36237.5 36496.1 34840.8 35516.0 35741.9 35906.1 36045.0 30154.1 31707.0 31794.8 31882.4 32117.0 23845.0 24120.3 24329.6 24434.0 25143.9 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,741 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39705.08 Median:11822.34 stddev:120565.29 (1019.8%) stddev-sans-first:120867.30 16:02:14 INFO - 2015-11-19 16:02:14,742 DEBUG : BROWSER_OUTPUT: Values: 357.7 361.4 364.0 364.3 365.5 15423.6 19790.7 19853.5 20313.7 20909.5 21066.7 21267.9 21324.8 21394.1 21494.9 6551.2 6730.6 6733.2 6736.1 6737.6 5001.7 6721.7 7596.7 7613.5 7623.2 7361.5 7521.4 7546.2 7580.5 7602.4 7438.2 7456.9 7458.7 7471.9 7499.6 6233.5 7003.0 7043.3 7154.1 7212.7 24700.5 24840.6 25298.6 26764.9 26804.7 2138.4 2149.8 2184.2 2190.6 2354.9 12429.7 15532.5 15545.2 15615.4 15792.8 1579.9 1921.0 1934.9 1952.4 1991.8 107675.5 111943.9 113439.4 114167.4 114796.0 18765.8 18833.0 19172.3 19227.7 19267.7 22826.2 26850.5 27479.5 28106.4 28206.0 9492.1 10450.8 10458.3 10540.3 10542.6 8087.2 8792.2 8888.0 8948.9 8956.2 4262.1 4263.1 8509.9 8701.8 8728.4 1861.4 1883.8 1889.6 1901.4 1931.0 731.9 855.2 925.1 931.6 1005.4 11625.8 11885.8 11901.8 11918.5 20829.9 420.3 428.4 438.0 443.9 452.5 11402.2 11811.5 11883.6 11944.4 11958.8 619685.0 713832.4 751181.0 775016.1 782525.0 129898.4 130172.7 130235.0 130566.7 133492.0 479.5 484.5 486.7 487.1 487.4 11211.2 11307.5 11367.5 11479.7 11487.0 33853.0 46306.1 53122.7 53875.0 54875.5 72005.6 73242.6 73297.3 74104.3 76903.6 9738.8 9790.6 10082.6 10098.3 10162.2 19523.4 19768.5 19978.8 20187.1 20274.4 15782.4 16037.5 16129.8 16327.5 16479.9 12926.2 14049.5 14542.1 15432.2 15589.9 16189.2 16191.4 16320.3 16625.5 16718.3 9931.1 9946.7 9955.7 10053.2 10073.3 10406.7 14544.7 16477.8 16497.5 16968.5 16:02:14 INFO - 2015-11-19 16:02:14,743 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,743 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5829.69 Median:5260.84 stddev:2994.28 (56.9%) stddev-sans-first:2985.24 16:02:14 INFO - 2015-11-19 16:02:14,744 DEBUG : BROWSER_OUTPUT: Values: 1530.6 1573.6 1899.5 1909.2 1916.6 7291.2 7370.0 8350.2 8468.9 8505.4 8186.0 8240.3 8302.8 8315.9 8355.4 2365.3 2391.3 2394.8 2403.8 2408.9 2404.0 2427.8 2439.5 2446.8 2451.4 2236.0 2251.4 2287.5 2288.3 2289.9 2001.0 2325.4 2373.8 2374.4 2378.2 2378.1 2382.6 2390.0 2407.5 2425.0 8314.5 8392.7 8397.8 8439.2 8478.0 4527.3 5075.5 5193.7 5208.6 5213.6 3158.4 3443.3 3446.9 3520.9 3595.3 1027.6 1048.0 1053.1 1083.2 1084.0 10000.9 10248.9 11078.6 11080.9 11091.0 4314.8 4362.5 4690.9 4805.0 4819.0 9586.8 9592.0 9597.3 9605.5 9641.8 5183.2 5197.3 5237.5 5257.7 5264.0 4681.1 4760.8 4787.1 4793.5 4801.8 3902.5 3903.1 3916.9 3924.1 3929.7 1279.6 1284.3 1293.5 1294.6 1299.4 1146.7 1147.5 1154.9 1158.5 1163.7 7832.3 7947.9 7960.8 7983.9 8004.9 1025.0 1140.9 1186.3 1209.3 1224.5 5863.7 6189.2 6256.2 6273.1 6279.0 9038.6 10247.4 10274.4 10332.8 10356.5 9760.8 9876.8 10107.0 10107.8 10190.8 6723.6 7837.0 7892.5 7922.3 7942.4 7693.9 7826.2 7831.6 7896.3 7923.0 8853.6 8975.6 9042.6 9088.7 9093.2 9164.4 9243.3 9274.0 9462.1 9480.5 7310.9 7329.9 7401.9 7403.9 7406.7 7982.2 8012.2 8038.6 8075.6 8079.9 7488.1 7508.4 7519.0 7620.2 7652.2 7377.1 7407.1 7450.9 7453.5 7493.7 7432.4 7466.3 7508.7 7517.0 7550.4 6825.1 6841.7 6892.3 6896.9 6908.2 6829.7 6848.3 6949.2 6950.4 6960.0 16:02:14 INFO - 2015-11-19 16:02:14,744 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,744 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5972.13 Median:6619.05 stddev:1928.60 (29.1%) stddev-sans-first:1886.75 16:02:14 INFO - 2015-11-19 16:02:14,745 DEBUG : BROWSER_OUTPUT: Values: 318.7 322.7 325.2 326.4 333.1 6613.9 6813.8 6871.6 6882.6 6974.1 5354.0 5663.5 6613.9 6686.1 6766.7 4076.5 4968.7 5095.6 5118.7 5126.9 4116.3 5081.0 5099.0 5099.9 5100.9 4827.9 5020.9 5042.3 5047.6 5056.8 4996.7 5005.4 5009.2 5035.3 5041.5 4093.9 4207.7 4215.5 4302.0 4308.5 6521.7 6567.8 6586.8 6605.7 6624.2 5903.1 5905.1 5915.1 5927.0 5947.9 7078.3 7266.6 7289.3 7317.9 7329.1 4833.8 4854.6 4855.8 4863.4 4871.2 7697.2 7793.3 7840.8 7846.9 7852.2 4814.5 4930.4 4931.2 4939.9 4958.1 5048.4 5051.6 5056.8 5073.7 5078.9 4770.7 5912.1 5974.1 5981.0 6017.4 5925.9 7382.1 7391.0 7403.8 7412.6 1711.2 1743.7 1747.2 1749.9 1752.7 1111.7 1115.5 1126.1 1127.5 1135.9 5984.2 6891.3 6909.3 6936.3 6963.8 7561.8 7615.2 7648.9 7653.6 7660.9 6781.2 6875.7 6890.3 6969.6 7056.4 3349.9 4004.4 4010.2 4074.9 4114.7 8011.6 8020.1 8020.3 8059.9 8085.6 7957.0 7978.3 7992.6 8000.2 8002.8 7531.5 7724.6 7773.8 8006.9 8052.4 7712.4 7721.7 7745.6 7752.3 7889.3 7317.9 7533.4 7536.9 7557.5 7585.4 7985.8 8001.7 8004.8 8011.1 8020.3 4743.2 4779.4 4783.3 4784.7 4802.3 7403.3 7644.5 7671.6 7678.7 7687.1 5878.5 5960.3 6324.8 7348.4 7374.2 5958.1 6606.0 6680.7 7057.9 7354.5 5889.9 6904.9 7193.1 7225.6 7259.2 7364.1 7380.3 7402.4 7410.0 7432.8 7077.5 7179.3 7217.0 7245.1 7303.0 16:02:14 INFO - 2015-11-19 16:02:14,745 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-19 16:02:14,746 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18921.06 Median:27420.07 stddev:26753.92 (97.6%) stddev-sans-first:26793.67 16:02:14 INFO - 2015-11-19 16:02:14,747 DEBUG : BROWSER_OUTPUT: Values: 616.3 715.7 764.8 789.6 854.8 14917.7 14989.6 15307.8 15318.6 16930.7 15622.9 15760.6 15767.2 15768.8 15821.8 940.1 949.3 957.7 960.8 967.2 955.5 955.6 963.5 973.3 975.8 1002.5 1005.9 1008.9 1011.1 1014.3 980.8 994.2 1007.5 1008.7 1018.1 720.4 722.6 727.3 732.1 732.6 12561.6 15193.4 15344.8 15349.2 15361.8 11483.5 12468.6 12560.1 12660.4 13148.0 10307.5 10489.8 10558.2 10575.6 10820.9 3471.5 3533.8 3537.6 3597.3 3725.1 69729.0 70702.6 71692.6 83151.6 84080.6 9297.2 9507.4 9609.5 9685.8 10044.4 20311.4 20798.3 21029.3 21112.6 21244.0 7160.2 7180.4 7405.1 7442.9 7524.0 4145.5 4176.4 4181.0 4228.9 4255.4 2994.0 3575.1 3599.7 3607.2 3625.2 661.7 662.6 663.2 670.2 673.0 491.3 503.3 514.1 514.5 544.5 8448.7 8803.3 8810.9 8824.6 9018.2 593.8 619.5 628.8 630.1 636.0 3956.9 4327.5 4400.2 4416.0 4505.0 94191.5 95551.5 97723.0 97833.0 98162.0 78253.6 79882.8 82102.6 83025.0 86947.7 75186.6 75298.0 75916.6 75965.9 77160.6 7458.3 9036.1 9082.3 9105.0 9224.3 54206.7 54225.0 54295.6 54503.5 55112.4 47678.7 76489.6 77361.1 77549.2 78166.0 10981.3 11084.8 11118.4 11608.8 11662.0 11883.8 12493.3 12522.1 12826.3 12896.9 11124.8 11878.4 11966.7 11992.5 12363.8 11274.8 11524.4 11816.1 11888.7 12444.0 8275.2 10991.1 11273.1 11491.5 12435.4 9419.3 9508.8 9733.4 9762.8 9771.0 9172.2 9188.6 9324.4 9843.8 9956.4 16:02:14 INFO - 2015-11-19 16:02:14,747 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:02:14 INFO - 2015-11-19 16:02:14,747 DEBUG : BROWSER_OUTPUT: 16:02:15 INFO - 2015-11-19 16:02:15,157 INFO : Browser exited with error code: 0 16:02:15 INFO - 2015-11-19 16:02:15,176 INFO : Completed test dromaeo_css (00:18:30) 16:02:15 INFO - 2015-11-19 16:02:15,176 INFO : Starting test kraken 16:02:15 INFO - 2015-11-19 16:02:15,176 DEBUG : operating with platform_type : mac_ 16:02:15 INFO - 2015-11-19 16:02:15,176 INFO : Initialising browser for kraken test... 16:02:15 INFO - 2015-11-19 16:02:15,188 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmph94mbK/profile http://localhost:50405/getInfo.html 16:02:17 INFO - 2015-11-19 16:02:17,600 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:02:17 INFO - 2015-11-19 16:02:17,600 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:02:17 INFO - 2015-11-19 16:02:17,600 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:02:17 INFO - 2015-11-19 16:02:17,601 DEBUG : BROWSER_OUTPUT: __metrics 16:02:18 INFO - 2015-11-19 16:02:18,321 INFO : Browser initialized. 16:02:18 INFO - 2015-11-19 16:02:18,321 INFO : Running cycle 1/1 for kraken test... 16:02:18 INFO - 2015-11-19 16:02:18,321 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmph94mbK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:02:30 INFO - 2015-11-19 16:02:30,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 236785664 16:02:30 INFO - 2015-11-19 16:02:30,284 DEBUG : BROWSER_OUTPUT: 16:02:33 INFO - 2015-11-19 16:02:33,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50405/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:33 INFO - 2015-11-19 16:02:33,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 248758272 16:02:33 INFO - 2015-11-19 16:02:33,660 DEBUG : BROWSER_OUTPUT: 16:02:36 INFO - 2015-11-19 16:02:36,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50405/tests/kraken/driver.html?testName=audio-dft) 16:02:36 INFO - 2015-11-19 16:02:36,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 258531328 16:02:36 INFO - 2015-11-19 16:02:36,850 DEBUG : BROWSER_OUTPUT: 16:02:40 INFO - 2015-11-19 16:02:40,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50405/tests/kraken/driver.html?testName=audio-fft) 16:02:40 INFO - 2015-11-19 16:02:40,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 261300224 16:02:40 INFO - 2015-11-19 16:02:40,829 DEBUG : BROWSER_OUTPUT: 16:02:42 INFO - 2015-11-19 16:02:42,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50405/tests/kraken/driver.html?testName=audio-oscillator) 16:02:43 INFO - 2015-11-19 16:02:43,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 261840896 16:02:43 INFO - 2015-11-19 16:02:43,451 DEBUG : BROWSER_OUTPUT: 16:02:45 INFO - 2015-11-19 16:02:45,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:45 INFO - 2015-11-19 16:02:45,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 263987200 16:02:45 INFO - 2015-11-19 16:02:45,981 DEBUG : BROWSER_OUTPUT: 16:02:48 INFO - 2015-11-19 16:02:48,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50405/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:49 INFO - 2015-11-19 16:02:49,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 262717440 16:02:49 INFO - 2015-11-19 16:02:49,372 DEBUG : BROWSER_OUTPUT: 16:02:52 INFO - 2015-11-19 16:02:52,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50405/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:52 INFO - 2015-11-19 16:02:52,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 262934528 16:02:52 INFO - 2015-11-19 16:02:52,801 DEBUG : BROWSER_OUTPUT: 16:02:55 INFO - 2015-11-19 16:02:55,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50405/tests/kraken/driver.html?testName=json-parse-financial) 16:02:56 INFO - 2015-11-19 16:02:56,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 262950912 16:02:56 INFO - 2015-11-19 16:02:56,415 DEBUG : BROWSER_OUTPUT: 16:02:57 INFO - 2015-11-19 16:02:57,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:58 INFO - 2015-11-19 16:02:58,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 264130560 16:02:58 INFO - 2015-11-19 16:02:58,509 DEBUG : BROWSER_OUTPUT: 16:03:00 INFO - 2015-11-19 16:03:00,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:00 INFO - 2015-11-19 16:03:00,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 263970816 16:03:00 INFO - 2015-11-19 16:03:00,929 DEBUG : BROWSER_OUTPUT: 16:03:02 INFO - 2015-11-19 16:03:02,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:03 INFO - 2015-11-19 16:03:03,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 264462336 16:03:03 INFO - 2015-11-19 16:03:03,581 DEBUG : BROWSER_OUTPUT: 16:03:06 INFO - 2015-11-19 16:03:06,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:06 INFO - 2015-11-19 16:03:06,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 263892992 16:03:06 INFO - 2015-11-19 16:03:06,710 DEBUG : BROWSER_OUTPUT: 16:03:09 INFO - 2015-11-19 16:03:09,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:09 INFO - 2015-11-19 16:03:09,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 264765440 16:03:09 INFO - 2015-11-19 16:03:09,797 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50405/tests/kraken/driver.html?testName=ai-astar) 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 265920512 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:03:11 INFO - 2015-11-19 16:03:11,851 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:03:11 INFO - 2015-11-19 16:03:11,852 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;115;167;165;116;123;114;118;145;129 16:03:11 INFO - 2015-11-19 16:03:11,852 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;149;149;151;122;141;162;120;156;134 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |2;audio-dft;277;271;223;199;214;197;200;204;199;198 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;95;106;132;56;57;60;60;128;84 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;78;109;76;78;77;111;77;76;111 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;75;132;132;93;87;88;87;87;88;91 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;96;95;96;96;96;101;151;128;96 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;148;152;91;92;92;91;96;102;155;149 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;56;59;59;60;67;61;57 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;65;66;66;67;71;78;61;69 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;85;108;102;85;85;84;82;84 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;127;108;138;133;138;134;109;124;130 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;177;175;142;141;138;137;143;139;138;140 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;76;58;88;102;99;92;100;79;68 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:03:11 INFO - 2015-11-19 16:03:11,853 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:03:11 INFO - 2015-11-19 16:03:11,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,811 16:03:11 INFO - 2015-11-19 16:03:11,854 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:03:11 INFO - 2015-11-19 16:03:11,854 DEBUG : BROWSER_OUTPUT: __startTimestamp1447977791851__endTimestamp 16:03:11 INFO - 2015-11-19 16:03:11,854 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:130.70 Median:126.00 stddev:20.84 (16.5%) stddev-sans-first:21.32 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: Values: 115.0 115.0 167.0 165.0 116.0 123.0 114.0 118.0 145.0 129.0 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,856 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.00 stddev:13.84 (9.3%) stddev-sans-first:14.66 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: Values: 145.0 149.0 149.0 151.0 122.0 141.0 162.0 120.0 156.0 134.0 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:218.20 Median:209.00 stddev:30.58 (14.6%) stddev-sans-first:23.91 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: Values: 277.0 271.0 223.0 199.0 214.0 197.0 200.0 204.0 199.0 198.0 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.40 Median:60.00 stddev:28.97 (48.3%) stddev-sans-first:30.53 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: Values: 76.0 95.0 106.0 132.0 56.0 57.0 60.0 60.0 128.0 84.0 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.00 Median:77.00 stddev:16.12 (20.9%) stddev-sans-first:16.69 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 109.0 76.0 78.0 77.0 111.0 77.0 76.0 111.0 16:03:11 INFO - 2015-11-19 16:03:11,857 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:87.50 stddev:19.54 (22.3%) stddev-sans-first:19.20 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: Values: 75.0 132.0 132.0 93.0 87.0 88.0 87.0 87.0 88.0 91.0 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:104.90 Median:96.00 stddev:19.11 (19.9%) stddev-sans-first:19.86 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 95.0 96.0 96.0 96.0 101.0 151.0 128.0 96.0 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.80 Median:91.00 stddev:29.67 (32.6%) stddev-sans-first:29.24 16:03:11 INFO - 2015-11-19 16:03:11,858 DEBUG : BROWSER_OUTPUT: Values: 148.0 152.0 91.0 92.0 92.0 91.0 96.0 102.0 155.0 149.0 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.50 stddev:2.95 (5.0%) stddev-sans-first:3.11 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 56.0 59.0 59.0 60.0 67.0 61.0 57.0 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:4.48 (6.7%) stddev-sans-first:4.71 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 65.0 66.0 66.0 67.0 71.0 78.0 61.0 69.0 16:03:11 INFO - 2015-11-19 16:03:11,859 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,860 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:84.00 stddev:9.14 (10.9%) stddev-sans-first:9.43 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 85.0 108.0 102.0 85.0 85.0 84.0 82.0 84.0 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:131.50 stddev:10.70 (8.1%) stddev-sans-first:11.34 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: Values: 128.0 127.0 108.0 138.0 133.0 138.0 134.0 109.0 124.0 130.0 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:141.50 stddev:15.41 (10.9%) stddev-sans-first:11.92 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: Values: 177.0 175.0 142.0 141.0 138.0 137.0 143.0 139.0 138.0 140.0 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.70 Median:77.50 stddev:15.81 (20.4%) stddev-sans-first:15.42 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: Values: 65.0 76.0 58.0 88.0 102.0 99.0 92.0 100.0 79.0 68.0 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:03:11 INFO - 2015-11-19 16:03:11,861 DEBUG : BROWSER_OUTPUT: 16:03:12 INFO - 2015-11-19 16:03:12,476 INFO : Browser exited with error code: 0 16:03:12 INFO - 2015-11-19 16:03:12,523 INFO : Completed test kraken (00:00:57) 16:03:12 INFO - 2015-11-19 16:03:12,523 INFO : Starting test v8_7 16:03:12 INFO - 2015-11-19 16:03:12,523 DEBUG : operating with platform_type : mac_ 16:03:12 INFO - 2015-11-19 16:03:12,523 INFO : Initialising browser for v8_7 test... 16:03:12 INFO - 2015-11-19 16:03:12,536 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpmhEk1j/profile http://localhost:50405/getInfo.html 16:03:15 INFO - 2015-11-19 16:03:15,250 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:03:15 INFO - 2015-11-19 16:03:15,250 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:03:15 INFO - 2015-11-19 16:03:15,251 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:03:15 INFO - 2015-11-19 16:03:15,251 DEBUG : BROWSER_OUTPUT: __metrics 16:03:15 INFO - 2015-11-19 16:03:15,828 INFO : Browser initialized. 16:03:15 INFO - 2015-11-19 16:03:15,828 INFO : Running cycle 1/1 for v8_7 test... 16:03:15 INFO - 2015-11-19 16:03:15,829 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpmhEk1j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:03:27 INFO - 2015-11-19 16:03:27,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 235610112 16:03:27 INFO - 2015-11-19 16:03:27,945 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50405/tests/v8_7/run.html (next: http://localhost:50405/tests/v8_7/run.html) 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 247418880 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: |0;Richards;644.3298969072165 16:03:49 INFO - 2015-11-19 16:03:49,625 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;156.20118712902217 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.8489289740699 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5445.652173913043 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |5;Earley;869.5652173913044 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |6;Boyer;12810.12658227848 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |8;Splay;784.9293563579278 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4522.522522522522 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: __startTimestamp1447977829622__endTimestamp 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,626 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:644.33 Median:644.33 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: Values: 644.3 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:156.20 Median:156.20 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: Values: 156.2 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: Values: 281.8 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5445.65 Median:5445.65 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,627 DEBUG : BROWSER_OUTPUT: Values: 5445.7 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: Values: 950.6 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:869.57 Median:869.57 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: Values: 869.6 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12810.13 Median:12810.13 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: Values: 12810.1 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: Values: 26842.1 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,628 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: Values: 784.9 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4522.52 Median:4522.52 stddev:0.00 (0.0%) 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: Values: 4522.5 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:03:49 INFO - 2015-11-19 16:03:49,629 DEBUG : BROWSER_OUTPUT: 16:03:50 INFO - 2015-11-19 16:03:50,446 INFO : Browser exited with error code: 0 16:03:50 INFO - 2015-11-19 16:03:50,464 INFO : Completed test v8_7 (00:00:37) 16:03:50 INFO - 2015-11-19 16:03:50,660 INFO : Completed test suite (00:20:05) 16:03:50 INFO - 2015-11-19 16:03:50,661 DEBUG : Working with test: dromaeo_css 16:03:50 INFO - 2015-11-19 16:03:50,661 DEBUG : Generating results file: dromaeo_css 16:03:50 INFO - 2015-11-19 16:03:50,662 DEBUG : Working with test: kraken 16:03:50 INFO - 2015-11-19 16:03:50,662 DEBUG : Generating results file: kraken 16:03:50 INFO - 2015-11-19 16:03:50,662 INFO : javascript benchmark 16:03:50 INFO - 2015-11-19 16:03:50,662 DEBUG : Working with test: v8_7 16:03:50 INFO - 2015-11-19 16:03:50,662 DEBUG : Generating results file: v8_7 16:03:50 INFO - 2015-11-19 16:03:50,662 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:03:51 INFO - 2015-11-19 16:03:51,185 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 16:03:51 INFO - 2015-11-19 16:03:51,185 DEBUG : process_Request line: dromaeo_css 7758.47 graph.html#tests=[[72,1,61]] 16:03:51 INFO - 2015-11-19 16:03:51,185 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:03:51 INFO - 2015-11-19 16:03:51,212 DEBUG : process_Request line: kraken 1553.80 graph.html#tests=[[232,1,61]] 16:03:51 INFO - 2015-11-19 16:03:51,212 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:03:51 INFO - 2015-11-19 16:03:51,238 DEBUG : process_Request line: v8_7 18224.00 graph.html#tests=[[230,1,61]] 16:03:51 INFO - 2015-11-19 16:03:51,239 INFO : javascript benchmark 16:03:51 INFO - 2015-11-19 16:03:51,241 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3468.9479657805127, 3549.94675079874, 3565.9108522286924, 3584.2473080653062, 3591.5690117185927, 5880.794172203974, 5919.082542205954, 5925.437083477068, 5955.553333499983, 5963.314218864832, 5720.771169153229, 5892.322382925965, 5897.115432685099, 5921.467067963882, 5989.490893274077, 5298.549623282016, 5329.467053294678, 5344.4922732340365, 5386.272853164812, 5411.512963833255, 944.403328389833, 5318.946810531884, 5347.491988261109, 5354.973225133869, 5447.782088716466, 5312.946870531284, 5321.148616221425, 5337.866553336159, 5341.145416733323, 5358.571314294847, 5329.626926115174, 5331.840044798662, 5342.305500284977, 5387.73061346935, 5408.161734931092, 5090.490950904917, 5108.719020453874, 5211.088059589557, 5270.288511050997, 5302.655327403706, 4870.293807397908, 5419.674819510803, 5694.886102277973, 5756.395578464243, 5855.092460668603, 6326.810195694136, 6348.555601107924, 6352.333005034498, 6360.968195158995, 6368.681565921732, 6211.0, 6311.779087731908, 6319.273283572356, 6460.547761656686, 6467.870642587169, 4343.718603012119, 4997.375328083989, 5553.694881702797, 5563.693996830173, 6101.115338275925, 6314.778982735582, 6494.9350506495275, 6509.8698026040165, 6539.346065393518, 6560.081588577603, 6118.558266176196, 6159.784407545714, 6257.7184026718905, 6285.842853928689, 6299.181106456132, 4633.675642704979, 6339.651319177489, 6415.26224484181, 6415.903761443582, 6418.711157997808, 6109.617229398918, 6231.844203894848, 6289.465395441439, 6345.714442850082, 6367.936320636827, 6176.7838125666285, 6263.123162757218, 6296.496280297565, 6306.558540902093, 6315.210598675166, 5066.36670416198, 5068.138416469209, 5069.518395752398, 5084.669496482717, 5107.361579802525, 4416.0, 4458.08609235106, 4508.661850361171, 4586.289125185602, 4600.5169457207185, 6028.969855150784, 6046.0, 6067.75728970845, 6095.542834287447, 6137.232845894263, 6347.809565713036, 6386.744530218739, 6419.967900160469, 6426.646534440557, 6427.517936154713, 5889.234399528034, 6068.150458935753, 6071.0286354184, 6074.453299203093, 6170.629762214281, 5563.5271001964475, 5573.247611572467, 5577.330720313507, 5578.693171875586, 5578.9163162552595, 5867.70661466925, 6353.30113687494, 6598.142241508669, 6598.901016484852, 6605.801825945326, 6113.445900579521, 6198.504119670506, 6255.374462553708, 6298.84252893663, 6312.305646378986, 6523.902141467976, 6538.574992625464, 6565.606063636197, 6576.638284894377, 6586.37429444202, 6145.354737752472, 6358.650274234961, 6388.361163883575, 6391.840203994937, 6402.327755585783, 6226.128342032029, 6313.2424109107205, 6344.809655710336, 6348.396902294275, 6350.142730731292, 6292.150559674568, 6303.432691057827, 6305.148804911461, 6306.243250809932, 6334.0, 6096.420840020191, 6132.754689812357, 6193.752249909953, 6309.274433440213, 6322.367763223825, 6097.282711137887, 6215.160953271251, 6227.252729672287, 6249.0626406039455, 6288.905666414916, 5620.887582248414, 6286.717097730521, 6301.991681330965, 6306.590071645328, 6336.0, 4913.557779799835, 6006.369331220334, 6069.696515174312, 6211.9068213975925, 6261.436470717657], "unit": "ms", "name": "dojo.html", "value": 5781.155739998353}, {"lowerIsBetter": false, "replicates": [540.3138014721304, 551.1952549278054, 589.8407429993902, 590.1236663554623, 619.5632079384034, 40828.0, 41340.96647583812, 41515.377269340985, 41552.79223603882, 41562.58437415625, 45266.321005184946, 45459.77270113653, 45523.63429097124, 45658.543414565844, 45664.54335456644, 9764.072413120743, 9866.112049915506, 9899.059589339036, 9962.850557241647, 9981.251406144533, 9693.515324233795, 9729.756756081119, 9802.950985245065, 9819.656312029081, 9824.901750982506, 9735.221182305399, 9767.97436269192, 9847.950760246189, 9878.2591305652, 9896.851547226797, 8450.830983380298, 9749.26880483963, 9862.60549578016, 9877.506124693737, 9881.16010139139, 9647.276454265888, 9734.36726612768, 9751.951240243825, 9792.21662267017, 9828.115469607697, 34433.13917152066, 41096.38355424671, 41298.0, 41321.793391033156, 41565.376519352234, 2802.817816841919, 3187.9203019924457, 3235.4823228283362, 3360.2607426366403, 3422.709069729051, 28347.149585512263, 29275.707242927725, 29300.974465893592, 29354.0, 29425.411491770046, 2800.7339302766204, 2819.2247132038647, 2821.9435611287863, 2877.223149749577, 2958.1421387797513, 456266.0, 459617.70191149163, 461101.0, 461574.0, 463527.682361586, 59435.702821486484, 60436.697816510634, 69313.0, 70924.0, 70956.64521677462, 66838.0, 67715.32284677189, 67972.98040529396, 68223.65888170627, 68925.0, 16561.00633961966, 16730.4144354947, 16783.91608041952, 16803.0, 16933.830661693224, 12600.054995875345, 12724.172928759786, 12742.68143296425, 12789.360531973363, 12830.67923301925, 20016.69974950377, 20038.398848034583, 20188.798112018692, 20328.0, 20335.694964575545, 8644.524551149621, 8688.261497772633, 8699.478031318014, 8708.69519566812, 8801.987771406242, 942.8020115775764, 943.4480828715141, 966.1787480641539, 1081.4862940103544, 1096.0738176241064, 23152.0, 29583.0, 29896.0, 30332.54501182484, 30528.694713053028, 1052.5421441672897, 1137.135776809614, 1142.3774043146504, 1180.8760080191628, 1189.7620475904853, 14741.705165896621, 15916.363345466283, 15992.92003539998, 16109.758353624706, 16229.2696828643, 520540.0, 523449.0, 529348.0, 530218.0, 532294.0, 59530.0, 60122.39877601168, 60407.69796150991, 60705.69647151736, 60828.391716082275, 1278.3161008860402, 1284.1973766396002, 1421.3106643278002, 1427.750143724844, 1442.9422823087168, 30139.69860301369, 30289.545656814724, 30381.848090759406, 30499.695003050572, 30718.692813071582, 50946.49053509418, 51333.743331283105, 51358.0, 51680.74159629178, 51716.638418502676, 507495.0, 509965.0, 513385.0, 514291.0, 516148.0, 31076.446177691476, 33424.83287583546, 33445.83277083599, 34026.489602655485, 34203.828980855935, 34417.82791086029, 42650.57349426466, 43178.35232471453, 43246.0, 43689.344659830764, 35075.649243507236, 36210.637893620726, 36818.63181368152, 36852.81573592115, 37241.510339586115, 35381.46927796137, 36064.0, 36089.81955090208, 36237.45643815292, 36496.08759781027, 34840.82579587086, 35516.0, 35741.927742167776, 35906.10234744152, 36045.0, 30154.09537713872, 31707.0, 31794.84102579472, 31882.36235275328, 32117.0, 23845.04619815188, 24120.276391708278, 24329.635055473827, 24434.022639094237, 25143.87428062921], "unit": "ms", "name": "ext.html", "value": 20026.296553457763}, {"lowerIsBetter": false, "replicates": [357.6637960317303, 361.353177811717, 364.01715368505035, 364.26418634358595, 365.4755425963744, 15423.641309743633, 19790.70313945292, 19853.503662408446, 20313.695294570574, 20909.47726306843, 21066.683999740017, 21267.893660531674, 21324.786752132473, 21394.14423423061, 21494.89252553735, 6551.213854337474, 6730.596164230137, 6733.225679046924, 6736.124303840494, 6737.562058466208, 5001.724905130216, 6721.731130754764, 7596.6581503832185, 7613.505122167069, 7623.161452240249, 7361.4846960712775, 7521.398288136936, 7546.2076481969425, 7580.507267027653, 7602.429817763662, 7438.181800001996, 7456.888146677804, 7458.701651933916, 7471.887921681179, 7499.625018749068, 6233.501319894398, 7002.964985175042, 7043.295670432967, 7154.069970903801, 7212.7114915403845, 24700.505989880283, 24840.627390589154, 25298.620520692206, 26764.866175668998, 26804.73195268042, 2138.422625891016, 2149.7850214978534, 2184.2194378597947, 2190.6385446401323, 2354.85870847748, 12429.689257768538, 15532.534023979299, 15545.222738863125, 15615.375384984587, 15792.842071579253, 1579.8657114145312, 1920.9711854322197, 1934.8935808530525, 1952.4142757172933, 1991.800819918011, 107675.46162269216, 111943.88056119416, 113439.43280283628, 114167.42916285449, 114796.0, 18765.812341876408, 18832.964186969573, 19172.328968486316, 19227.711584326247, 19267.710984335245, 22826.17390608747, 26850.462990740467, 27479.450410992067, 28106.437871242462, 28206.0, 9492.050794920591, 10450.843237351446, 10458.320209186379, 10540.262181647364, 10542.631007914686, 8087.191280871866, 8792.208701216921, 8887.955560222286, 8948.8657670135, 8956.193942545202, 4262.147570485915, 4263.062126332264, 8509.872351914726, 8701.825963480822, 8728.389012769045, 1861.4043506078197, 1883.8304552590332, 1889.5842914558775, 1901.4390754727388, 1930.9903450482939, 731.9240716147254, 855.2260204514924, 925.1396201532639, 931.6366617019368, 1005.4319309590059, 11625.767484650429, 11885.762284754257, 11901.761964760657, 11918.52325906954, 20829.89585052065, 420.26453706014473, 428.4066567803552, 438.0428763152522, 443.87349605362965, 452.470609387018, 11402.20184587071, 11811.527538898348, 11883.64349069512, 11944.402779860971, 11958.804119588145, 619685.0, 713832.4308378529, 751181.0, 775016.1249193718, 782525.0, 129898.35050824874, 130172.69827301796, 130235.0, 130566.69433305736, 133492.0, 479.4701854450851, 484.5033840313707, 486.69338316860154, 487.14749188919393, 487.4467479410894, 11211.215214934877, 11307.547698092314, 11367.48846301935, 11479.655610331703, 11486.966173044466, 33853.0, 46306.07387852291, 53122.73438632782, 53875.0, 54875.451245487035, 72005.6399717998, 73242.63378683286, 73297.26702732904, 74104.25895741189, 76903.61548192223, 9738.80522389534, 9790.608375664893, 10082.596696132367, 10098.283291840258, 10162.18702503783, 19523.414297571097, 19768.505787355432, 19978.800211997695, 20187.0915808786, 20274.391768246976, 15782.36870525212, 16037.518874433787, 16129.838701612834, 16327.510174694778, 16479.91760041192, 12926.224426534438, 14049.508267210598, 14542.054766440571, 15432.2283885803, 15589.922050389676, 16189.190540473164, 16191.433299834449, 16320.265588048804, 16625.50123496297, 16718.33126674968, 9931.056549627774, 9946.651867184613, 9955.701328960144, 10053.246006549392, 10073.294869359075, 10406.687799366031, 14544.709105817612, 16477.83522164763, 16497.505074847773, 16968.49094527166], "unit": "ms", "name": "jquery.html", "value": 10384.087695866641}, {"lowerIsBetter": false, "replicates": [1530.632648164441, 1573.6380632454536, 1899.5441094137407, 1909.2267631609186, 1916.5687720262943, 7291.234420385849, 7369.963150184255, 8350.206730360622, 8468.915310846889, 8505.447145935517, 8185.959070204655, 8240.340772738182, 8302.833943321146, 8315.875261871077, 8355.415120941536, 2365.349528879555, 2391.330427480308, 2394.832361734679, 2403.807695384374, 2408.903643854244, 2403.9639405408934, 2427.817913656474, 2439.512097580482, 2446.779789818916, 2451.44842410458, 2236.049678886475, 2251.3921241264848, 2287.531056133497, 2288.3135059482174, 2289.919852805152, 2000.9699854502194, 2325.4186453386656, 2373.8338316317863, 2374.4182675244588, 2378.2270762002245, 2378.120095564635, 2382.559226543095, 2389.9522009559887, 2407.5064611754547, 2425.0, 8314.542700151489, 8392.706255281097, 8397.790055248606, 8439.156084391572, 8478.0, 4527.3435351873795, 5075.543201111917, 5193.740312984373, 5208.5572726318305, 5213.582913366921, 3158.4472717274384, 3443.345764304774, 3446.913827154341, 3520.894373168809, 3595.334863050318, 1027.5786927359748, 1048.0, 1053.0838170791385, 1083.2254937719567, 1084.046039485248, 10000.94999525005, 10248.923862994427, 11078.556857725762, 11080.944595277053, 11091.001809837073, 4314.770290467264, 4362.476502819682, 4690.882727931829, 4805.038992201574, 4819.012102518976, 9586.760330991641, 9592.0, 9597.328187026842, 9605.47169905648, 9641.758956026155, 5183.248428977777, 5197.272381866542, 5237.476252374732, 5257.658252213594, 5264.0261551613075, 4681.133990211822, 4760.785764640599, 4787.066522028241, 4793.520647935178, 4801.831935882297, 3902.512185976753, 3903.1217975955183, 3916.8824935251987, 3924.1170736584613, 3929.7445666031617, 1279.584135156078, 1284.3321472834075, 1293.5213970830853, 1294.5792617399384, 1299.408769010117, 1146.6560031990537, 1147.529512899707, 1154.9018333441752, 1158.5134243617701, 1163.668354518958, 7832.295093441618, 7947.9205207948335, 7960.761177164694, 7983.920160798434, 8004.879926801103, 1025.041586116983, 1140.8916152965455, 1186.347508870118, 1209.2683926224684, 1224.455117472716, 5863.677497737665, 6189.164462797555, 6256.217972753406, 6273.0904018917, 6278.968605156945, 9038.593263303035, 10247.38515689061, 10274.383536987805, 10332.845007324897, 10356.482175891175, 9760.755981100529, 9876.753081173028, 10107.0, 10107.797844043225, 10190.796184076276, 6723.562968407038, 7837.0, 7892.526448413114, 7922.286994170552, 7942.44402891792, 7693.92285080078, 7826.2173782621285, 7831.569263690551, 7896.32881205104, 7922.960385198037, 8853.557322133996, 8975.640974360953, 9042.63829446841, 9088.727338179866, 9093.22707569864, 9164.358494905293, 9243.260539156718, 9274.0, 9462.101100395452, 9480.525973701426, 7310.926890731024, 7329.890051649123, 7401.851962960603, 7403.925960740324, 7406.740764073232, 7982.241687039722, 8012.198780121941, 8038.598070096355, 8075.596220189084, 8079.919200807916, 7488.138864030706, 7508.399328053852, 7519.0, 7620.237976202336, 7652.196519365609, 7377.077865266841, 7407.111146662435, 7450.8882366763455, 7453.478256521991, 7493.662785174572, 7432.368248698921, 7466.290702383265, 7508.699652013858, 7517.02278703765, 7550.3582195514, 6825.078614387193, 6841.726330946706, 6892.276310987274, 6896.931030689629, 6908.171019477695, 6829.692663830239, 6848.280930502226, 6949.166100067822, 6950.374466298057, 6959.965200173967], "unit": "ms", "name": "mootools.html", "value": 4788.571246879725}, {"lowerIsBetter": false, "replicates": [318.6717680788787, 322.69505317474983, 325.175679652082, 326.4026830899454, 333.08900158067695, 6613.867722645544, 6813.761518346859, 6871.622060786654, 6882.552634078781, 6974.128233970754, 5353.973230133844, 5663.546916246701, 6613.867722645544, 6686.130802995616, 6766.695498702558, 4076.51081870176, 4968.677035992649, 5095.6178286628465, 5118.692878427288, 5126.948730512684, 4116.34138537834, 5081.0, 5099.0, 5099.9235011474675, 5100.923486147711, 4827.8551643450755, 5020.924686129711, 5042.319286896277, 5047.596192304607, 5056.797728090872, 4996.725180115092, 5005.399352077738, 5009.198528235464, 5035.320231768701, 5041.521055499722, 4093.8771836844944, 4207.747535147871, 4215.536291007987, 4301.978490107561, 4308.504521979981, 6521.706523206467, 6567.770128045496, 6586.769463068769, 6605.669716514203, 6624.238212605564, 5903.114532820068, 5905.114232865061, 5915.112733090028, 5926.97036514819, 5947.92937271291, 7078.32755888195, 7266.600336981464, 7289.307515785992, 7317.926820731778, 7329.120505539369, 4833.830815921461, 4854.611631069506, 4855.757212139414, 4863.392075990501, 4871.171900776876, 7697.230276972314, 7793.298603125802, 7840.843183136362, 7846.882296765553, 7852.21477852216, 4814.542618451242, 4930.359053323045, 4931.18635425158, 4939.876503087452, 4958.107540642719, 5048.419431765394, 5051.621128415383, 5056.797728090835, 5073.720945348041, 5078.923816142761, 4770.666053376231, 5912.083627037816, 5974.103884417285, 5980.970095149496, 6017.428344307284, 5925.911111333334, 7382.114146302478, 7390.96304518474, 7403.777886663409, 7412.555246685216, 1711.238498867992, 1743.747156662277, 1747.1700942052423, 1749.860011199101, 1752.6932786762266, 1111.6720567432626, 1115.4590023838593, 1126.1328776841785, 1127.5489804078434, 1135.8977692007759, 5984.192134061933, 6891.27641597635, 6909.309069093151, 6936.271691472423, 6963.82590435233, 7561.7731468056045, 7615.162332143571, 7648.923510764821, 7653.579053152019, 7660.923390766021, 6781.220159681699, 6875.656217189121, 6890.276520965226, 6969.6166710830375, 7056.400205982549, 3349.949750753741, 4004.379321205218, 4010.1779135277197, 4074.898127546776, 4114.691398145092, 8011.599420028975, 8020.077691065486, 8020.318272946864, 8059.919400806034, 8085.595720213966, 7957.0, 7978.3218426434405, 7992.560409177551, 8000.239977202156, 8002.839943201104, 7531.472796904273, 7724.648186567329, 7773.805654858561, 8006.919930800617, 8052.396070294752, 7712.38300935935, 7721.691132354643, 7745.573993430416, 7752.26353496417, 7889.250521200477, 7317.926820731725, 7533.39732821362, 7536.886946695694, 7557.5465472071855, 7585.393168546613, 7985.760427187193, 8001.679932802623, 8004.83990320202, 8011.078725946591, 8020.278174964281, 4743.217369134054, 4779.402574678165, 4783.330333753347, 4784.736839473862, 4802.303665968485, 7403.296686814744, 7644.503107298008, 7671.61641917913, 7678.654460549177, 7687.077550693953, 5878.500327472213, 5960.254968128984, 6324.841878953063, 7348.448866335153, 7374.151972523228, 5958.136070269873, 6606.009098635243, 6680.665966701743, 7057.8707406814665, 7354.485186036926, 5889.882202355843, 6904.895216765293, 7193.136823581203, 7225.5664660120565, 7259.2377800332315, 7364.116306043309, 7380.261973802577, 7402.407807375289, 7409.999650047174, 7432.814179645336, 7077.504574679723, 7179.282071792779, 7217.025701530226, 7245.130584329914, 7303.014093097364], "unit": "ms", "name": "prototype.html", "value": 5328.193560160928}, {"lowerIsBetter": false, "replicates": [616.3497510126816, 715.7280233511267, 764.7667461424263, 789.6288744290182, 854.8162145138793, 14917.701645967074, 14989.5503134906, 15307.846921530781, 15318.617034574127, 16930.661386772288, 15622.921885390586, 15760.605984850385, 15767.211639418041, 15768.76346854798, 15821.841781582181, 940.1350757303263, 949.3354651743772, 957.707899090777, 960.7886265021684, 967.2358836519142, 955.5126885288519, 955.6177528988391, 963.498980530124, 973.2797729680057, 975.8389865672191, 1002.5338217728792, 1005.9144972677332, 1008.8638033865444, 1011.1152741351318, 1014.2747935226312, 980.8283550378655, 994.1897353656783, 1007.531497853498, 1008.6973907827622, 1018.0684673523717, 720.3768740039881, 722.5520177489938, 727.2545640718254, 732.0848938826467, 732.6153769271122, 12561.56034538796, 15193.392264309414, 15344.846551534565, 15349.155796431192, 15361.769573456408, 11483.540658373655, 12468.563600274038, 12560.057995650362, 12660.39776153247, 13148.01389895752, 10307.536160872778, 10489.842652360221, 10558.155347572252, 10575.629852955186, 10820.891791082067, 3471.5139880416764, 3533.840977156034, 3537.6108628050893, 3597.3165098631175, 3725.105974566112, 69729.0, 70702.64648676723, 71692.64153679251, 83151.5842420784, 84080.57959710223, 9297.209737172281, 9507.429554226768, 9609.519524023772, 9685.806283874283, 10044.447555384379, 20311.390658280274, 20798.27206047781, 21029.263975760776, 21112.577748444946, 21244.0, 7160.248173941765, 7180.425565954711, 7405.111386633531, 7442.925570744332, 7524.021877156044, 4145.54399016108, 4176.352665336878, 4180.979095104505, 4228.873133805991, 4255.361695745601, 2993.9550906736417, 3575.12409459684, 3599.7300202484917, 3607.2244467439627, 3625.184333524936, 661.7121552124842, 662.6322391073, 663.2339647706906, 670.1723371636026, 672.9871543327359, 491.3244289102484, 503.29036059157147, 514.1413838889064, 514.4752352600327, 544.4963408846801, 8448.662053517914, 8803.251723603566, 8810.911890881138, 8824.647014119364, 9018.23345015681, 593.7921727395463, 619.5198720991268, 628.7516431009817, 630.0527197110109, 635.9506813757245, 3956.940645890314, 4327.502337231259, 4400.22995975703, 4416.028473735773, 4504.977475112603, 94191.52904235572, 95551.52224238974, 97723.0, 97833.0, 98162.0, 78253.60873195711, 79882.80175797251, 82102.58948705219, 83025.0, 86947.69578456329, 75186.62406688041, 75298.0, 75916.62041689867, 75965.86051209236, 77160.61419692865, 7458.291462311072, 9036.05121462237, 9082.318826087938, 9105.043970383014, 9224.308176886627, 54206.728966354916, 54225.0, 54295.64260893509, 54503.45496545143, 55112.44887551073, 47678.708916197706, 76489.61755191188, 77361.06597335111, 77549.2245077542, 78166.0, 10981.341119532854, 11084.833727493933, 11118.388488633203, 11608.767824643628, 11662.0, 11883.76232475363, 12493.312867792358, 12522.060845436446, 12826.294553799258, 12896.935515322364, 11124.777504450027, 11878.406079696153, 11966.700832479257, 11992.520299187934, 12363.75272494527, 11274.830877536679, 11524.423778811193, 11816.113791465847, 11888.702782430508, 12444.0, 8275.234768180344, 10991.06575941054, 11273.098152147972, 11491.482883270106, 12435.440405181607, 9419.29085048351, 9508.809823803347, 9733.367331123454, 9762.75593110178, 9770.951145244228, 9172.174504294646, 9188.570749320092, 9324.440533568008, 9843.753906152404, 9956.352837065568], "unit": "ms", "name": "yui.html", "value": 7109.667684339451}], "name": "dromaeo_css", "value": 7758.465373942455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 115.0, 167.0, 165.0, 116.0, 123.0, 114.0, 118.0, 145.0, 129.0], "unit": "ms", "name": "ai-astar", "value": 130.7}, {"lowerIsBetter": true, "replicates": [145.0, 149.0, 149.0, 151.0, 122.0, 141.0, 162.0, 120.0, 156.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [277.0, 271.0, 223.0, 199.0, 214.0, 197.0, 200.0, 204.0, 199.0, 198.0], "unit": "ms", "name": "audio-dft", "value": 218.2}, {"lowerIsBetter": true, "replicates": [76.0, 95.0, 106.0, 132.0, 56.0, 57.0, 60.0, 60.0, 128.0, 84.0], "unit": "ms", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 109.0, 76.0, 78.0, 77.0, 111.0, 77.0, 76.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 87.0}, {"lowerIsBetter": true, "replicates": [75.0, 132.0, 132.0, 93.0, 87.0, 88.0, 87.0, 87.0, 88.0, 91.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 96.0}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 96.0, 96.0, 96.0, 101.0, 151.0, 128.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 104.9}, {"lowerIsBetter": true, "replicates": [148.0, 152.0, 91.0, 92.0, 92.0, 91.0, 96.0, 102.0, 155.0, 149.0], "unit": "ms", "name": "imaging-desaturate", "value": 116.8}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 56.0, 59.0, 59.0, 60.0, 67.0, 61.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 67.0, 71.0, 78.0, 61.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 108.0, 102.0, 85.0, 85.0, 84.0, 82.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 108.0, 138.0, 133.0, 138.0, 134.0, 109.0, 124.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [177.0, 175.0, 142.0, 141.0, 138.0, 137.0, 143.0, 139.0, 138.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [65.0, 76.0, 58.0, 88.0, 102.0, 99.0, 92.0, 100.0, 79.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 82.7}], "name": "kraken", "value": 1553.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [644.3298969072165], "unit": "score", "name": "Richards", "value": 54.78870400000001}, {"lowerIsBetter": false, "replicates": [156.20118712902217], "unit": "score", "name": "DeltaBlue", "value": 423.287436}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5445.652173913043], "unit": "score", "name": "Decrypt", "value": 48.87954491017965}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [869.5652173913044], "unit": "score", "name": "Earley", "value": 766.43245}, {"lowerIsBetter": false, "replicates": [12810.12658227848], "unit": "score", "name": "Boyer", "value": 52.026261857707496}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Splay", "value": 103.81953400000005}, {"lowerIsBetter": false, "replicates": [4522.522522522522], "unit": "score", "name": "NavierStokes", "value": 328.13545816733085}], "name": "v8_7", "value": 18223.99652232903}]} 16:03:51 INFO - RETURN: dromaeo_css: 7758.47 16:03:51 INFO - RETURN: kraken: 1553.80 16:03:51 INFO - RETURN: v8_7: 18224.00 16:03:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "18224.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1553.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7758.47"}}} 16:03:51 INFO - Return code: 0 16:03:51 INFO - # TBPL SUCCESS # 16:03:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:51 INFO - 2015-11-19 16:03:51.317 screenresolution[2568:25795] starting screenresolution argv=screenresolution get 16:03:51 INFO - 2015-11-19 16:03:51.320 screenresolution[2568:25795] Display 0: 1600x1200x32@60 16:03:51 INFO - 2015-11-19 16:03:51.326 screenresolution[2569:25798] starting screenresolution argv=screenresolution list 16:03:51 INFO - Available Modes on Display 0 16:03:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:51 INFO - Intel Iris: 16:03:51 INFO - Chipset Model: Intel Iris 16:03:51 INFO - Type: GPU 16:03:51 INFO - Bus: Built-In 16:03:51 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:51 INFO - Vendor: Intel (0x8086) 16:03:51 INFO - Device ID: 0x0a2e 16:03:51 INFO - Revision ID: 0x0009 16:03:51 INFO - Displays: 16:03:51 INFO - Display: 16:03:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:51 INFO - Display Serial Number: 1600x1200 60 16:03:51 INFO - Main Display: Yes 16:03:51 INFO - Mirror: Off 16:03:51 INFO - Online: Yes 16:03:51 INFO - Rotation: Supported 16:03:51 INFO - Return code: 0 16:03:51 INFO - Running post-action listener: _resource_record_post_action 16:03:51 INFO - Running post-run listener: _resource_record_post_run 16:03:52 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 0; Write bytes: 692666880; Read time: 0; Write time: 2059 16:03:52 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338442752; Write bytes: 336451072; Read time: 26114; Write time: 606 16:03:52 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 0; Write bytes: 343462912; Read time: 0; Write time: 1410 16:03:52 INFO - Running post-run listener: _upload_blobber_files 16:03:52 INFO - Blob upload gear active. 16:03:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:03:52 INFO - Copying logs to upload dir... 16:03:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.480346 ========= master_lag: 17.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-19 16:04:09.696041) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:04:09.701203) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 build_url:https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009717 build_url: 'https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:04:09.755865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2015-11-19 16:04:09.756203) ========= 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.wueuXMmB0x/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.5ykQIguPB8/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005277 ========= master_lag: 12.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2015-11-19 16:04:22.531086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:04:22.531515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:04:22.732380) ========= ========= Total master_lag: 30.04 =========