builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1447977247.19 results: success (0) buildid: 20151119134712 builduid: 19c69006c42e48c09eeae7c3db7a0db4 revision: cc325db44f6f8a58604d60b746c140e73f3d8216 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.194717) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.195128) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.195444) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005383 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.220834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.221110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.237623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.237898) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005437 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.286652) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.287063) ========= 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:54:07.287428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.287844) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.65M=0.001s 2015-11-19 15:54:07 (9.65 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.433765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.434132) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.026756 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.484727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:07.485210) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc325db44f6f8a58604d60b746c140e73f3d8216 --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 cc325db44f6f8a58604d60b746c140e73f3d8216 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:07,560 truncating revision to first 12 chars 2015-11-19 15:54:07,560 Setting DEBUG logging. 2015-11-19 15:54:07,560 attempt 1/10 2015-11-19 15:54:07,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc325db44f6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 15:54:08,212 unpacking tar archive at: mozilla-central-cc325db44f6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:08.396936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:08.397380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:08.408822) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:54:08.409188) ========= 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:54:08.409649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 15:54:08.409987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:08 INFO - MultiFileLogger online at 20151119 15:54:08 in /builds/slave/test 15:54:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:54:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:08 INFO - {'append_to_log': False, 15:54:08 INFO - 'base_work_dir': '/builds/slave/test', 15:54:08 INFO - 'blob_upload_branch': 'Firefox', 15:54:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:08 INFO - 'branch': 'Firefox', 15:54:08 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:08 INFO - 'config_files': ('talos/mac_config.py',), 15:54:08 INFO - 'default_actions': ('clobber', 15:54:08 INFO - 'read-buildbot-config', 15:54:08 INFO - 'download-and-extract', 15:54:08 INFO - 'populate-webroot', 15:54:08 INFO - 'create-virtualenv', 15:54:08 INFO - 'install', 15:54:08 INFO - 'run-tests'), 15:54:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:08 INFO - 'download_minidump_stackwalk': True, 15:54:08 INFO - 'download_symbols': 'ondemand', 15:54:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:08 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:08 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:08 INFO - 'installer_path': 'installer.exe', 15:54:08 INFO - 'log_level': 'info', 15:54:08 INFO - 'log_name': 'talos', 15:54:08 INFO - 'log_to_console': True, 15:54:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:54:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:54:08 INFO - 'opt_config_files': (), 15:54:08 INFO - 'pip_index': False, 15:54:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:54:08 INFO - 'cmd': ('bash', 15:54:08 INFO - '-c', 15:54:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:54:08 INFO - 'enabled': True, 15:54:08 INFO - 'halt_on_failure': False, 15:54:08 INFO - 'name': 'check_screen_resolution'},), 15:54:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:54:08 INFO - 'cmd': ('bash', 15:54:08 INFO - '-c', 15:54:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:54:08 INFO - 'enabled': True, 15:54:08 INFO - 'halt_on_failure': False, 15:54:08 INFO - 'name': 'check_screen_resolution'},), 15:54:08 INFO - 'run_cmd_checks_enabled': True, 15:54:08 INFO - 'sps_profile': False, 15:54:08 INFO - 'sps_profile_interval': 0, 15:54:08 INFO - 'suite': 'dromaeojs', 15:54:08 INFO - 'system_bits': '64', 15:54:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:08 INFO - 'title': 't-yosemite-r7-0013', 15:54:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:08 INFO - 'use_talos_json': True, 15:54:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:08 INFO - 'work_dir': 'build'} 15:54:08 INFO - ##### 15:54:08 INFO - ##### Running clobber step. 15:54:08 INFO - ##### 15:54:08 INFO - Running pre-action listener: _resource_record_pre_action 15:54:08 INFO - Running main action method: clobber 15:54:08 INFO - rmtree: /builds/slave/test/build 15:54:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:09 INFO - Running post-action listener: _resource_record_post_action 15:54:09 INFO - ##### 15:54:09 INFO - ##### Running read-buildbot-config step. 15:54:09 INFO - ##### 15:54:09 INFO - Running pre-action listener: _resource_record_pre_action 15:54:09 INFO - Running main action method: read_buildbot_config 15:54:09 INFO - Using buildbot properties: 15:54:09 INFO - { 15:54:09 INFO - "properties": { 15:54:09 INFO - "buildnumber": 1, 15:54:09 INFO - "product": "firefox", 15:54:09 INFO - "script_repo_revision": "production", 15:54:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:54:09 INFO - "repository": "", 15:54:09 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:54:09 INFO - "buildid": "20151119134712", 15:54:09 INFO - "slavename": "t-yosemite-r7-0013", 15:54:09 INFO - "pgo_build": "False", 15:54:09 INFO - "basedir": "/builds/slave/test", 15:54:09 INFO - "project": "", 15:54:09 INFO - "platform": "yosemite_r7", 15:54:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:54:09 INFO - "slavebuilddir": "test", 15:54:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:54:09 INFO - "branch": "mozilla-central", 15:54:09 INFO - "repo_path": "mozilla-central", 15:54:09 INFO - "stage_platform": "macosx64", 15:54:09 INFO - "builduid": "19c69006c42e48c09eeae7c3db7a0db4", 15:54:09 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 15:54:09 INFO - }, 15:54:09 INFO - "sourcestamp": { 15:54:09 INFO - "repository": "", 15:54:09 INFO - "hasPatch": false, 15:54:09 INFO - "project": "", 15:54:09 INFO - "branch": "mozilla-central-macosx64-talos", 15:54:09 INFO - "changes": [ 15:54:09 INFO - { 15:54:09 INFO - "category": null, 15:54:09 INFO - "files": [ 15:54:09 INFO - { 15:54:09 INFO - "url": null, 15:54:09 INFO - "name": "https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:54:09 INFO - } 15:54:09 INFO - ], 15:54:09 INFO - "repository": "", 15:54:09 INFO - "rev": "cc325db44f6f8a58604d60b746c140e73f3d8216", 15:54:09 INFO - "who": "kwierso@gmail.com", 15:54:09 INFO - "when": 1447976681, 15:54:09 INFO - "number": 6685867, 15:54:09 INFO - "comments": "Merge b2ginbound to central, a=merge", 15:54:09 INFO - "project": "", 15:54:09 INFO - "at": "Thu 19 Nov 2015 15:44:41", 15:54:09 INFO - "branch": "mozilla-central-macosx64-talos", 15:54:09 INFO - "revlink": "", 15:54:09 INFO - "properties": [ 15:54:09 INFO - [ 15:54:09 INFO - "buildid", 15:54:09 INFO - "20151119134712", 15:54:09 INFO - "Change" 15:54:09 INFO - ], 15:54:09 INFO - [ 15:54:09 INFO - "builduid", 15:54:09 INFO - "19c69006c42e48c09eeae7c3db7a0db4", 15:54:09 INFO - "Change" 15:54:09 INFO - ], 15:54:09 INFO - [ 15:54:09 INFO - "pgo_build", 15:54:09 INFO - "False", 15:54:09 INFO - "Change" 15:54:09 INFO - ] 15:54:09 INFO - ], 15:54:09 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 15:54:09 INFO - } 15:54:09 INFO - ], 15:54:09 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 15:54:09 INFO - } 15:54:09 INFO - } 15:54:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:54:09 INFO - Running post-action listener: _resource_record_post_action 15:54:09 INFO - ##### 15:54:09 INFO - ##### Running download-and-extract step. 15:54:09 INFO - ##### 15:54:09 INFO - Running pre-action listener: _resource_record_pre_action 15:54:09 INFO - Running main action method: download_and_extract 15:54:09 INFO - mkdir: /builds/slave/test/build/tests 15:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:09 INFO - https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/test_packages.json 15:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/test_packages.json 15:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:54:11 INFO - Downloaded 1149 bytes. 15:54:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:54:11 INFO - Using the following test package requirements: 15:54:11 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:54:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:54:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'jsshell-mac.zip'], 15:54:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:54:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:54:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:54:11 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:54:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:54:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:54:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:54:11 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:54:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:11 INFO - https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:54:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:12 INFO - Downloaded 17522561 bytes. 15:54:12 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:54:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:54:15 INFO - Return code: 0 15:54:15 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:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:15 INFO - https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:21 INFO - Downloaded 17522561 bytes. 15:54:21 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:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:54:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:54:24 INFO - Return code: 0 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:24 INFO - https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:25 INFO - Downloaded 11130997 bytes. 15:54:25 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:54:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:54:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:54:26 INFO - Return code: 0 15:54: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:54:26 INFO - https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/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:54:29 INFO - Downloaded 109424291 bytes. 15:54:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:54:29 INFO - mkdir: /builds/slave/test/properties 15:54:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:29 INFO - Contents: 15:54:29 INFO - build_url:https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:54:29 INFO - Running post-action listener: _resource_record_post_action 15:54:29 INFO - Running post-action listener: set_extra_try_arguments 15:54:29 INFO - ##### 15:54:29 INFO - ##### Running populate-webroot step. 15:54:29 INFO - ##### 15:54:29 INFO - Running pre-action listener: _resource_record_pre_action 15:54:29 INFO - Running main action method: populate_webroot 15:54:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:29 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:54:29 INFO - '../fennec_ids.txt'], 15:54:29 INFO - 'tests': ['tcheck2']}, 15:54:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:29 INFO - '--tppagecycles', 15:54:29 INFO - '7'], 15:54:29 INFO - 'tests': ['tsvgm']}}, 15:54:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:54:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:54:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:54:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'tests': ['damp', 'tps']}, 15:54:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['damp', 'tps']}, 15:54:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:54:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:29 INFO - 'other': {'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'other_l64': {'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'other_nol64': {'tests': ['a11yr', 15:54:29 INFO - 'ts_paint', 15:54:29 INFO - 'tpaint', 15:54:29 INFO - 'sessionrestore', 15:54:29 INFO - 'sessionrestore_no_auto_restore']}, 15:54:29 INFO - 'svgr': {'tests': ['tsvgx', 15:54:29 INFO - 'tsvgr_opacity', 15:54:29 INFO - 'tart', 15:54:29 INFO - 'tscrollx', 15:54:29 INFO - 'cart']}, 15:54:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['tsvgx', 15:54:29 INFO - 'tsvgr_opacity', 15:54:29 INFO - 'tart', 15:54:29 INFO - 'tscrollx', 15:54:29 INFO - 'cart']}, 15:54:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'tests': ['tp5o']}, 15:54:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'talos_options': ['--e10s'], 15:54:29 INFO - 'tests': ['tp5o']}, 15:54:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'talos_options': ['--xperf_path', 15:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:29 INFO - 'tests': ['tp5n']}, 15:54:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:29 INFO - 'talos_options': ['--e10s', 15:54:29 INFO - '--xperf_path', 15:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:29 INFO - 'tests': ['tp5n']}}, 15:54:29 INFO - 'talos.zip': {'path': '', 15:54:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:29 INFO - Running post-action listener: _resource_record_post_action 15:54:29 INFO - ##### 15:54:29 INFO - ##### Running create-virtualenv step. 15:54:29 INFO - ##### 15:54:29 INFO - Running pre-action listener: _resource_record_pre_action 15:54:29 INFO - Running main action method: create_virtualenv 15:54:29 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:29 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:54:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:29 INFO - Using real prefix '/tools/python27' 15:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:32 INFO - Installing pip.................done. 15:54:32 INFO - Return code: 0 15:54:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:32 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:32 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:54:32 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:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:32 INFO - 'HOME': '/Users/cltbld', 15:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:32 INFO - 'LOGNAME': 'cltbld', 15:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:32 INFO - 'MOZ_NO_REMOTE': '1', 15:54:32 INFO - 'NO_EM_RESTART': '1', 15:54:32 INFO - 'PAGER': '/bin/cat', 15:54:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:32 INFO - 'PWD': '/builds/slave/test', 15:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:32 INFO - 'SHELL': '/bin/bash', 15:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:32 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:32 INFO - 'USER': 'cltbld', 15:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:32 INFO - 'XPC_FLAGS': '0x0', 15:54:32 INFO - 'XPC_SERVICE_NAME': '0', 15:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:33 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:54:33 INFO - Cleaning up... 15:54:33 INFO - Return code: 0 15:54:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:33 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:33 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:54:33 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:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:33 INFO - 'HOME': '/Users/cltbld', 15:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:33 INFO - 'LOGNAME': 'cltbld', 15:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:33 INFO - 'MOZ_NO_REMOTE': '1', 15:54:33 INFO - 'NO_EM_RESTART': '1', 15:54:33 INFO - 'PAGER': '/bin/cat', 15:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:33 INFO - 'PWD': '/builds/slave/test', 15:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:33 INFO - 'SHELL': '/bin/bash', 15:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:33 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:33 INFO - 'USER': 'cltbld', 15:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:33 INFO - 'XPC_FLAGS': '0x0', 15:54:33 INFO - 'XPC_SERVICE_NAME': '0', 15:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:33 INFO - Downloading/unpacking psutil>=0.7.1 15:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:54:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:36 INFO - Installing collected packages: psutil 15:54:36 INFO - Running setup.py install for psutil 15:54:36 INFO - building 'psutil._psutil_osx' extension 15:54:36 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:54:36 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:54:36 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:54:36 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:54:37 INFO - building 'psutil._psutil_posix' extension 15:54:37 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:54:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:54:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:54:37 INFO - ^ 15:54:37 INFO - 1 warning generated. 15:54:37 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:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:37 INFO - Successfully installed psutil 15:54:37 INFO - Cleaning up... 15:54:37 INFO - Return code: 0 15:54:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:54:37 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:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:37 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:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:37 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:37 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:54:37 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:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:37 INFO - 'HOME': '/Users/cltbld', 15:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:37 INFO - 'LOGNAME': 'cltbld', 15:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:37 INFO - 'MOZ_NO_REMOTE': '1', 15:54:37 INFO - 'NO_EM_RESTART': '1', 15:54:37 INFO - 'PAGER': '/bin/cat', 15:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:37 INFO - 'PWD': '/builds/slave/test', 15:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:37 INFO - 'SHELL': '/bin/bash', 15:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:37 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:37 INFO - 'USER': 'cltbld', 15:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:37 INFO - 'XPC_FLAGS': '0x0', 15:54:37 INFO - 'XPC_SERVICE_NAME': '0', 15:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:54:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:39 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:54:39 INFO - Installing collected packages: mozsystemmonitor 15:54:39 INFO - Running setup.py install for mozsystemmonitor 15:54:39 INFO - Successfully installed mozsystemmonitor 15:54:39 INFO - Cleaning up... 15:54:40 INFO - Return code: 0 15:54:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:40 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:40 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:54:40 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:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:40 INFO - 'HOME': '/Users/cltbld', 15:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:40 INFO - 'LOGNAME': 'cltbld', 15:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:40 INFO - 'MOZ_NO_REMOTE': '1', 15:54:40 INFO - 'NO_EM_RESTART': '1', 15:54:40 INFO - 'PAGER': '/bin/cat', 15:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:40 INFO - 'PWD': '/builds/slave/test', 15:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:40 INFO - 'SHELL': '/bin/bash', 15:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:40 INFO - 'USER': 'cltbld', 15:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:40 INFO - 'XPC_FLAGS': '0x0', 15:54:40 INFO - 'XPC_SERVICE_NAME': '0', 15:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:40 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:42 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:54:42 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:54:42 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:54:42 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:54:42 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:54:42 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:54:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:43 INFO - Downloading docopt-0.6.1.tar.gz 15:54:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:43 INFO - Running setup.py install for blobuploader 15:54:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:43 INFO - Running setup.py install for requests 15:54:44 INFO - Running setup.py install for docopt 15:54:44 INFO - Successfully installed blobuploader requests docopt 15:54:44 INFO - Cleaning up... 15:54:44 INFO - Return code: 0 15:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:44 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:54:44 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:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:44 INFO - 'HOME': '/Users/cltbld', 15:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PAGER': '/bin/cat', 15:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test', 15:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:44 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - 'XPC_FLAGS': '0x0', 15:54:44 INFO - 'XPC_SERVICE_NAME': '0', 15:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:44 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-puFlMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:44 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-qNDJLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:44 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-98Y1RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-yYFHX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-8lHRVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-WptOCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-uP3gFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-enYAel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-S8HA13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-m62nO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-agAOgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ao_HFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:45 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Hyddhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9saJBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-aQH_Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YIQktq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HfC36p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:46 INFO - Running setup.py install for manifestparser 15:54:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:46 INFO - Running setup.py install for mozcrash 15:54:46 INFO - Running setup.py install for mozdebug 15:54:46 INFO - Running setup.py install for mozdevice 15:54:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Running setup.py install for mozfile 15:54:47 INFO - Running setup.py install for mozhttpd 15:54:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Running setup.py install for mozinfo 15:54:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Running setup.py install for mozInstall 15:54:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Running setup.py install for mozleak 15:54:47 INFO - Running setup.py install for mozlog 15:54:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:47 INFO - Running setup.py install for moznetwork 15:54:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:48 INFO - Running setup.py install for mozprocess 15:54:48 INFO - Running setup.py install for mozprofile 15:54:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:48 INFO - Running setup.py install for mozrunner 15:54:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:48 INFO - Running setup.py install for mozscreenshot 15:54:48 INFO - Running setup.py install for moztest 15:54:48 INFO - Running setup.py install for mozversion 15:54:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:49 INFO - Cleaning up... 15:54:49 INFO - Return code: 0 15:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:49 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:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:49 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:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:49 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:49 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:54:49 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:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:49 INFO - 'HOME': '/Users/cltbld', 15:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:49 INFO - 'LOGNAME': 'cltbld', 15:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:49 INFO - 'MOZ_NO_REMOTE': '1', 15:54:49 INFO - 'NO_EM_RESTART': '1', 15:54:49 INFO - 'PAGER': '/bin/cat', 15:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:49 INFO - 'PWD': '/builds/slave/test', 15:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:49 INFO - 'SHELL': '/bin/bash', 15:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:49 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:49 INFO - 'USER': 'cltbld', 15:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:49 INFO - 'XPC_FLAGS': '0x0', 15:54:49 INFO - 'XPC_SERVICE_NAME': '0', 15:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-kVTvrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-r_2gqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lYB8FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZUbrou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YihPG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-yzAGTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:49 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:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:49 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JMxeAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1WqKXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4wPmY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Rf1Qhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-fw7t7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ORIEmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HeCkzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mJsmOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-f0JWO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:50 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:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-loKGTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:51 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:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LQa4fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:53 INFO - Downloading blessings-1.5.1.tar.gz 15:54:53 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:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:53 INFO - Installing collected packages: blessings 15:54:53 INFO - Running setup.py install for blessings 15:54:53 INFO - Successfully installed blessings 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:53 INFO - Reading from file tmpfile_stdout 15:54:53 INFO - Current package versions: 15:54:53 INFO - blessings == 1.5.1 15:54:53 INFO - blobuploader == 1.2.4 15:54:53 INFO - docopt == 0.6.1 15:54:53 INFO - manifestparser == 1.1 15:54:53 INFO - mozInstall == 1.12 15:54:53 INFO - mozcrash == 0.16 15:54:53 INFO - mozdebug == 0.1 15:54:53 INFO - mozdevice == 0.47 15:54:53 INFO - mozfile == 1.2 15:54:53 INFO - mozhttpd == 0.7 15:54:53 INFO - mozinfo == 0.9 15:54:53 INFO - mozleak == 0.1 15:54:53 INFO - mozlog == 3.0 15:54:53 INFO - moznetwork == 0.27 15:54:53 INFO - mozprocess == 0.22 15:54:53 INFO - mozprofile == 0.27 15:54:53 INFO - mozrunner == 6.11 15:54:53 INFO - mozscreenshot == 0.1 15:54:53 INFO - mozsystemmonitor == 0.0 15:54:53 INFO - moztest == 0.7 15:54:53 INFO - mozversion == 1.4 15:54:53 INFO - psutil == 3.1.1 15:54:53 INFO - requests == 1.2.3 15:54:53 INFO - wsgiref == 0.1.2 15:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 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 0x105cf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa310dc6830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, '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.URRUVaw6rT/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.eiTH48E2Gu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:54:53 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:54:53 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:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:53 INFO - 'HOME': '/Users/cltbld', 15:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PAGER': '/bin/cat', 15:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test', 15:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:54:53 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - 'XPC_FLAGS': '0x0', 15:54:53 INFO - 'XPC_SERVICE_NAME': '0', 15:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 INFO - Cleaning up... 15:54:54 INFO - Return code: 0 15:54:54 INFO - Running post-action listener: _resource_record_post_action 15:54:54 INFO - Running post-action listener: _start_resource_monitoring 15:54:54 INFO - Starting resource monitoring. 15:54:54 INFO - ##### 15:54:54 INFO - ##### Running install step. 15:54:54 INFO - ##### 15:54:54 INFO - Running pre-action listener: _resource_record_pre_action 15:54:54 INFO - Running main action method: install 15:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:54 INFO - Reading from file tmpfile_stdout 15:54:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:54 INFO - Reading from file tmpfile_stdout 15:54:54 INFO - Output received: 15:54:54 INFO - Usage: mozinstall [options] installer 15:54:54 INFO - Options: 15:54:54 INFO - -h, --help show this help message and exit 15:54:54 INFO - -d DEST, --destination=DEST 15:54:54 INFO - Directory to install application into. [default: 15:54:54 INFO - "/builds/slave/test"] 15:54:54 INFO - --app=APP Application being installed. [default: firefox] 15:54:54 INFO - mkdir: /builds/slave/test/build/application 15:54:54 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:54:54 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:55:24 INFO - Reading from file tmpfile_stdout 15:55:24 INFO - Output received: 15:55:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:55:24 INFO - Running post-action listener: _resource_record_post_action 15:55:24 INFO - ##### 15:55:24 INFO - ##### Running run-tests step. 15:55:24 INFO - ##### 15:55:24 INFO - Running pre-action listener: _resource_record_pre_action 15:55:24 INFO - Running main action method: run_tests 15:55:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:55:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:55:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:55:24 INFO - 2015-11-19 15:55:24.628 screenresolution[1640:7818] starting screenresolution argv=screenresolution get 15:55:24 INFO - 2015-11-19 15:55:24.630 screenresolution[1640:7818] Display 0: 1600x1200x32@60 15:55:24 INFO - 2015-11-19 15:55:24.636 screenresolution[1641:7821] starting screenresolution argv=screenresolution list 15:55:24 INFO - Available Modes on Display 0 15:55:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:55:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:55:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:55:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:55:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:55:24 INFO - Intel Iris: 15:55:24 INFO - Chipset Model: Intel Iris 15:55:24 INFO - Type: GPU 15:55:24 INFO - Bus: Built-In 15:55:24 INFO - VRAM (Dynamic, Max): 1536 MB 15:55:24 INFO - Vendor: Intel (0x8086) 15:55:24 INFO - Device ID: 0x0a2e 15:55:24 INFO - Revision ID: 0x0009 15:55:24 INFO - Displays: 15:55:24 INFO - Display: 15:55:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:55:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:55:24 INFO - Display Serial Number: 1600x1200 60 15:55:24 INFO - Main Display: Yes 15:55:24 INFO - Mirror: Off 15:55:24 INFO - Online: Yes 15:55:24 INFO - Rotation: Supported 15:55:24 INFO - Return code: 0 15:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:24 INFO - Python 2.7.3 15:55:24 INFO - Return code: 0 15:55:24 INFO - grabbing minidump binary from tooltool 15:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:24 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 0x105c179f0>, '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 0x105976db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c0a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:24 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:55:24 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:55:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:24 INFO - Return code: 0 15:55:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:24 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] in /builds/slave/test/build 15:55:24 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --webServer localhost 15:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.URRUVaw6rT/Render', 15:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:24 INFO - 'HOME': '/Users/cltbld', 15:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:24 INFO - 'LOGNAME': 'cltbld', 15:55:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:24 INFO - 'MOZ_NO_REMOTE': '1', 15:55:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:24 INFO - 'NO_EM_RESTART': '1', 15:55:24 INFO - 'PAGER': '/bin/cat', 15:55:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:24 INFO - 'PWD': '/builds/slave/test', 15:55:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:24 INFO - 'SHELL': '/bin/bash', 15:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiTH48E2Gu/Listeners', 15:55:24 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 15:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:24 INFO - 'USER': 'cltbld', 15:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:24 INFO - 'XPC_FLAGS': '0x0', 15:55:24 INFO - 'XPC_SERVICE_NAME': '0', 15:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] with output_timeout 3600 15:55:25 INFO - mozversion INFO | application_buildid: 20151119134712 15:55:25 INFO - mozversion INFO | application_changeset: cc325db44f6f8a58604d60b746c140e73f3d8216 15:55:25 INFO - mozversion INFO | application_display_name: Nightly 15:55:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:25 INFO - mozversion INFO | application_name: Firefox 15:55:25 INFO - mozversion INFO | application_remotingname: firefox 15:55:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:55:25 INFO - mozversion INFO | application_vendor: Mozilla 15:55:25 INFO - mozversion INFO | application_version: 45.0a1 15:55:25 INFO - mozversion INFO | platform_buildid: 20151119134712 15:55:25 INFO - mozversion INFO | platform_changeset: cc325db44f6f8a58604d60b746c140e73f3d8216 15:55:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:55:25 INFO - mozversion INFO | platform_version: 45.0a1 15:55:25 INFO - 2015-11-19 15:55:25,198 DEBUG : using testdate: 1447977325 15:55:25 INFO - 2015-11-19 15:55:25,199 DEBUG : actual date: 1447977325 15:55:25 INFO - 2015-11-19 15:55:25,762 INFO : starting webserver on 'localhost:49259' 15:55:25 INFO - 2015-11-19 15:55:25,763 INFO : Starting test suite t-yosemite-r7-0013 15:55:25 INFO - 2015-11-19 15:55:25,763 INFO : Starting test dromaeo_css 15:55:25 INFO - 2015-11-19 15:55:25,763 DEBUG : operating with platform_type : mac_ 15:55:25 INFO - 2015-11-19 15:55:25,764 INFO : Initialising browser for dromaeo_css test... 15:55:25 INFO - 2015-11-19 15:55:25,781 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp6TrNLp/profile http://localhost:49259/getInfo.html 15:55:28 INFO - 2015-11-19 15:55:28,071 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:55:28 INFO - 2015-11-19 15:55:28,072 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:55:28 INFO - 2015-11-19 15:55:28,072 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:55:28 INFO - 2015-11-19 15:55:28,072 DEBUG : BROWSER_OUTPUT: __metrics 15:55:28 INFO - 2015-11-19 15:55:28,088 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:28 INFO - 2015-11-19 15:55:28,345 DEBUG : BROWSER_OUTPUT: console.error: 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: Stack: 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 15:55:28 INFO - 2015-11-19 15:55:28,346 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:55:28 INFO - 2015-11-19 15:55:28,347 DEBUG : BROWSER_OUTPUT: 15:55:28 INFO - 2015-11-19 15:55:28,737 INFO : Browser initialized. 15:55:28 INFO - 2015-11-19 15:55:28,738 INFO : Running cycle 1/1 for dromaeo_css test... 15:55:28 INFO - 2015-11-19 15:55:28,738 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp6TrNLp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:55:40 INFO - 2015-11-19 15:55:40,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 226025472 15:55:40 INFO - 2015-11-19 15:55:40,618 DEBUG : BROWSER_OUTPUT: 15:56:31 INFO - 2015-11-19 15:56:31,584 DEBUG : BROWSER_OUTPUT: 1447977391583 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:58:42 INFO - 2015-11-19 15:58:42,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49259/tests/dromaeo/cssquery-ext.html) 15:58:44 INFO - 2015-11-19 15:58:44,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 362090496 15:58:44 INFO - 2015-11-19 15:58:44,385 DEBUG : BROWSER_OUTPUT: 16:01:47 INFO - 2015-11-19 16:01:47,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-ext.html (next: http://localhost:49259/tests/dromaeo/cssquery-jquery.html) 16:01:47 INFO - 2015-11-19 16:01:47,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 361873408 16:01:47 INFO - 2015-11-19 16:01:47,767 DEBUG : BROWSER_OUTPUT: 16:04:49 INFO - 2015-11-19 16:04:49,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49259/tests/dromaeo/cssquery-mootools.html) 16:04:50 INFO - 2015-11-19 16:04:50,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 359198720 16:04:50 INFO - 2015-11-19 16:04:50,453 DEBUG : BROWSER_OUTPUT: 16:07:52 INFO - 2015-11-19 16:07:52,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49259/tests/dromaeo/cssquery-prototype.html) 16:07:53 INFO - 2015-11-19 16:07:53,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 315301888 16:07:53 INFO - 2015-11-19 16:07:53,019 DEBUG : BROWSER_OUTPUT: 16:10:55 INFO - 2015-11-19 16:10:55,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49259/tests/dromaeo/cssquery-yui.html) 16:10:56 INFO - 2015-11-19 16:10:56,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 320720896 16:10:56 INFO - 2015-11-19 16:10:56,617 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-yui.html (next: http://localhost:49259/tests/dromaeo/cssquery-dojo.html) 16:13:59 INFO - 2015-11-19 16:13:59,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 402837504 16:13:59 INFO - 2015-11-19 16:13:59,677 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,679 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:13:59 INFO - 2015-11-19 16:13:59,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:13:59 INFO - 2015-11-19 16:13:59,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:13:59 INFO - 2015-11-19 16:13:59,679 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:13:59 INFO - 2015-11-19 16:13:59,681 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3465.792052476851;3527.5990031560104;3543.2736289060713;3553.5913369962464;3593.119685677009;5673.773049078032;5769.942300577003;5978.820635380935;5992.191054207675;5992.82021539354;5121.359830021247;5821.301443826736;5822.912656310159;5904.822855314347;6123.357047510003;5243.423223445437;5319.361676598814;5320.866978325554;5321.946780532184;5390.51485366317;5412.539934105586;5445.9727701361635;5463.344398672165;5478.534324582395;5500.724963751816;5148.613853960968;5252.737363131828;5289.153735402356;5376.865578360533;5390.164524498709;5300.469953004707;5328.49379308965;5330.200469929503;5337.199420086979;5337.2794672719465;5176.844694659167;5214.8696282592855;5258.658187217857;5267.947320526784;5274.7626356814035;5803.187553742479;5809.651420914759;5871.706414679292;5910.349861515273;5918.792842250544;6314.0844577536;6391.8402039948905;6394.9360506394805;6395.42441180296;6402.263739669905;6209.254889413254;6292;6416.262129855079;6423.7430502779835;6429.099926010363;5928.347881733006;5955.987482128048;5995.490383317423;6045.455908968214;6059.21230240066;6495.188101487314;6541.313162118005;6581.111549940792;6582.934170658328;6589.406953374123;6097.796915383809;6241.188645476059;6416.647084410402;6435.613863168225;6445;6314.273858506239;6396.232452105777;6452.290248072803;6453.741850326029;6467.094606755058;6403.231612206472;6412.2625898022325;6420.1974753155855;6430.196225471816;6447.065175549519;6126.527406317373;6328.367163283727;6392.648404337713;6399.456046236122;6408.327125651833;4990.126727822617;5014.373203349582;5014.398272207359;5111.386633603991;5118.769655365518;4518.88702782433;4565.56627120423;4571.131485017836;4577.130345234395;4602.148602508547;5091.3126727892;6061.605995610271;6081.75672973085;6096.237970253718;6103.969480152571;6256.436920677161;6290.654014029273;6344.777932772331;6376.904346434807;6410.1987251593555;6087.878242435127;6091;6128.9693551531955;6146.139540464339;6154.630722156685;5610.943890561124;5616.410276920946;5625.128105143709;5640.125780504029;5647.6893770843;6328.968355158287;6363.840903977438;6456.903146452807;6460.35396460369;6531.673416329069;6333.556651034383;6361.9502782040445;6369.394907483782;6402.199725034371;6407.583507072025;6522.641254731036;6536.084948107174;6536.575122617015;6541.771038013647;6571.178602674666;6082.087686846831;6183.876322473615;6239.875202495834;6259.624422534663;6417.903731443938;6386.074019267087;6399.7440102395385;6399.904001440075;6412.871742565216;6421.036844473367;5817.894600025981;6174.197354343906;6338.619682819046;6342.90485642725;6348.93651063502;5946;6173.41352571505;6232.501399888089;6262.68686565679;6284.183056202664;6176.845578860564;6184.752609895554;6242.219722534684;6249.96875015622;6267.498600111889;6350.7459701611415;6364.109024736633;6370.522210834299;6379.744810207725;6398.392152745481;5900.819836032725;6019.789307374396;6129.570930035033;6143.078538219303;6233.501319894488 16:13:59 INFO - 2015-11-19 16:13:59,682 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.1914408661308;555.9861003474911;566.8866226754649;640.1517988665017;647.6793986976446;31868.043958681217;39401.40897886534;39611;39645.99999999996;39654.810355689304;42851.571484285145;43241.78379108108;43353.78323108388;43442.004169520515;43466;8871;8988.77528061797;9774.413535187912;9991.100800927916;10013.49932503372;8867.68963086292;11874.16880818343;12031.217970831867;12045.578404755835;12092.576759813408;11747.765044699101;11857.110716696283;11857.822132668018;11862.644120676394;11891.702707432298;9019.143181397756;9093.136152065543;9174.495402752846;11625.6512304631;11765.235259708092;8843.513606751627;8943.50810705411;11997.040236781037;12117.697057573543;12126.454309556091;40209.19581608351;40377.596224037974;40390.39414408786;40540;40644.39033414501;3183.220111072802;3187.2031992002;3259.3970115528705;3489.1974845785358;3493.63316851732;29401.70598294011;29605;29643.70356296431;29670.703292967224;29930.251743706365;2421.9152329668377;2776.7917406194615;2800.9719902800916;2819.675737290197;2831.1506548035713;469554;472072;472151;472707;473014.6349268266;58321.708391457774;59306.70346648325;59313;59391;59594;70543;71332;71601;71715.64142179256;71861.28138718651;16183.43357982465;16675.332986680638;16683.6663266734;16691.415800446925;16750.916245418695;12653;12683.112182147346;12723.618291451272;12905.483780648856;12926.159799613182;20050.498737531387;20535.589288214152;20617.793822061587;20623;20665.89667051655;9219.861702074475;9474.900628604899;9491.952540237255;9492.667756628485;9567.234621230285;904.5115637555647;957.9425234485954;997.4563862694848;1055.6094245129352;1060.0194819791816;24982.250532484053;29242.41515169685;29650.55524167139;30222.395552088834;30331.545026824617;1044.1385856668278;1062.7236918401272;1081.6322450366756;1159.7448561316496;1207.5049229815734;14502.782458263135;14659;14685.97198196116;14713.337899794535;14839.70320593582;535186;535947;536301;536476;538330;57288;57564.71217643885;57633.13550296749;57747.422525775044;57809.421905781244;1328.7010422654826;1354.2619272496513;1454.9490767823074;1470.669099452636;1480.1193289992436;24936;28773.56839647449;29579.408411831213;30443.695563044974;30507.389852203276;49615.503844962535;53188.73405632947;53437;53452.46547534475;53568.46431535791;437622.36643434654;651972;653675;654485;655217;30458;31290.06129816109;31299.37401252008;31349.843250784514;31674.683253168096;43503.56496434995;43955.120897581226;44130.55869441265;44518;45442.545574545155;36995.815020924725;37382.626173739;37906.241875162894;38123.2375352497;38180.6181938177;35754.284914301046;36835.63164368322;36956.26087478289;37063;37074.814625926694;31980.840095800304;34265.82867085748;35361;35386.646133538336;35488.29023419569;28795.42409151847;32571.674283256863;32691.509627356085;32774.34451310913;32808.67191328056;19515.902420487808;23050.616962982276;24227.39431514226;24390.51218975575;24925.501489970462 16:13:59 INFO - 2015-11-19 16:13:59,685 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.19002649026424;362.8947605194493;365.71291536144133;367.81793012458826;372.68508110646496;12830.615081547545;17152.571185720364;20097.693649912744;21303.934803259854;21624.026918788673;21111.577768444622;21142.788572114274;21479.140834366644;21637.07899433576;21655.783442165575;4728.196206644879;6443.387878151568;6610.537262391635;6621.139251897247;6621.966890165542;4823.734694591796;4880.414350277972;7416.851662966737;7626.961865190667;7637.961810190941;4778.641601879855;5912.054071348585;5934.614250073753;7528.322450979438;7604.125525564548;5811.215485909412;5868.471837534642;5869.618474799125;5871.383504731984;5890.499307558863;5479.808206712746;5620.353659329188;5638.154276858463;5650.745716442729;5657.981563318601;25012.4997500049;25042;25179.866905989275;25550.61674074872;25752.613710794354;2017.273781438681;2050.1799280287855;2129.0419311309815;2131.872087674729;2175.445261458318;9721.854172187423;9943.90056099437;10055.597776088947;12564.869161775485;13755.656108597264;1644.1861278667018;1712.8115907250192;1744.5813004878864;1762.7620271263472;1785.803561608222;99333.5033324836;104007.9198416035;104411;105469.472652637;106007;10934.125269978382;10955.780884382268;10956.616518421977;10964.616238431776;11010.174236932102;13007.219566826021;13108.344582770824;13115.081944264;13119.934400327937;13126.671833204055;8544.2310192083;8594.398392112616;8594.699185528601;8623;8639.481631102153;8758.343124265706;8765;8791.340649451316;8809.471431714117;8852.468851868909;4012.9398059029136;4169.3120635094865;4175.248455278079;4218.472690913636;4286.935695964563;1453.694724107928;1535.7389243828577;1731.4892106828515;1758.3494107180425;1764.9294028238726;888.8844450221429;895.7312806158257;928.4522131942186;993.6919554937992;1014.771676372825;17048.48854534366;20073;20727.829936760147;20780.206284384916;20829.1668333268;969.1568335548118;979.0552117206929;1019.2457581389718;1048.8253156464655;1056.8995945385177;10669.253152279422;10837.403942783065;10854.294470859526;10855.240133190759;10876.72808179786;683619;691651;703074;708419;708859;102854;104655.4767226159;106386.46806765917;109538;120913;1147.8794726553758;1157.5196293538256;1167.9240849344765;1179.6755892129734;1181.4565299961941;18133.81866181374;18261.81738182601;18417.802842815174;18447.07764611791;18482.445526634223;51529.22706159486;52037.79508783182;52246.73876630593;52507.94984100373;52961.73519132534;57945.71027144837;80732;80766.78849817374;83705;90443;15650.45223417175;16215;16805.579860503585;16855.747163792308;16917.40789072426;16984.830151698818;19701.507462313555;20457.874816885214;21140.78859211388;21330.933453327583;13840.792388113985;15476.303566339317;16678.834835730104;16823.831761682228;17269.050202239;16709.2480838365;16991.40530081441;17077.487675369262;17307.134643268037;17310.480685579452;17808.287668493635;17964;18399.98800066009;18500.889946603245;18702.81297187065;12095;12694.365281735692;16551.83448165503;16910.66178676395;17206.22571984289;16706.66586668284;16846.326146953983;17388.13059347053;17435.04107274112;17475.650486990442 16:13:59 INFO - 2015-11-19 16:13:59,687 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1413.095618803965;1535.8387369326229;1543.1898253416955;1890.6029733755915;1902.1915685833521;7668.424868134891;7943.126256111837;7972.043354797425;7972.322352600021;7981.042274927009;7750.108737495176;8179.672813087484;8320.33437325014;8325.000999880007;8329.83340333193;2328.289871589169;2402.3994001499627;2404.146527982567;2405.3265085775924;2420.7579242075826;2370.928872133839;2407.963880541793;2437.2688193541867;2437.8659173745436;2445.364205306615;2305.9077636894503;2369.9763002370014;2397.424618091663;2408.9759102409016;2410.361254267612;2348.1194552042984;2366.597678394677;2398.568257713611;2402.615581506968;2403.2069417092407;2370.8696021718797;2391.1272385579136;2413.7827595516487;2424.5514579802793;2432.6351047342864;8368.456050356708;8459.619317130744;8465.492070475791;8470.364722645827;8472.661093556251;4711.411073615798;5101.15830887903;5198.896022079537;5206.114960456732;5247.737613119329;2964.889726034213;3204.3591281743743;3225.741940644766;3355.7986520808586;3466.185446420089;922.2806211155242;1033.1270076785104;1057.5135437698668;1062.1184416933927;1063.2132222155626;11078.501467433985;11107.333559986426;11122.49948752308;11140.053095486894;11174.27367221128;4673.579377856009;4742.383490146259;4777.474477807438;4786.760661966888;4802.255650374198;9598.136167744797;9609.615615375447;9636.662716804878;9643.324967252365;9650.179734722487;5224.425313215619;5255.789768409298;5266.4470230626;5275.366955965232;5296.232046353334;4822.95177048232;4826.0589185108565;4828.7102773833685;4831.637627177905;4835.274708793709;3663.87176448823;3674.614165512636;3679.0434487033563;3685.4103343465454;3710.6474884885893;1140.156284349592;1150.9079273658087;1152.3201311226417;1169.0238650726737;1170.789257933563;1110.5724296146043;1115.4088333183427;1162.1167912386647;1312.4946895445323;1424.8788852947616;7861.056673199253;7866.292033716879;7947.602619868983;7958.204179581995;7968.521888686697;1141.9257748246337;1159.4434671357797;1200.363807182195;1205.2467207995003;1205.7588482303574;5912.17229587858;6210.006398976142;6251.343608921089;6268.49852011838;6288.088227207029;8867.467951922905;9741.220702343795;10095.394276343442;10095.9495202525;10121.443320617289;9893.802123957481;9983.700488985342;9994.050565196294;10004.799904001879;10065.647702330383;7818.648160832776;7866.252705992922;7911.28798408146;7990.161033091442;7999.360131173095;6210.378962103753;7697.345725613385;7735.806604834924;7772.028496437945;7836.373090152888;9024;9077.001529831581;9128.178463938277;9164.221041211305;9205.493697846683;9010.909890901006;9192.402493837879;9331.346805723535;9504.619815207314;9518.23854091685;6133.3866613338305;7226.927730722836;7330.926690733238;7339.486235963432;7361.2638736125955;7830.256125668053;7924.247196516321;7930.484518506279;7940.6029698515995;7941.761747147595;7318.524295920748;7416.517926334771;7442.9255707442235;7502.624868756649;7595.506292090997;7341.669624866787;7351.522151060164;7441.8139546511775;7467.215942325977;7474.364679002346;7318.487705860539;7462.067241594801;7480.027596412431;7491;7498.962505187439;6802.8639427212165;6836.726530938906;6838.316168383122;6843.828904277433;6850.349216824394;6747.190337159573;6816.556923799937;6855.348741869514;6856.725730970905;6862.176538815374 16:13:59 INFO - 2015-11-19 16:13:59,688 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.3467458278244;321.25949685973836;324.6266793187834;330.82466292864785;335.2222843004228;6894.793666026873;7073.646317684108;7075.5942979387;7079.929200707991;7087.85824283514;6970.442364610832;6981.6509174541325;6981.685824137913;6984.05715228444;7008.61452620107;4297.591728785776;4924.236743304794;4979.377577802775;5028.2709007193935;5050.671706339085;4891.241857512091;4962.1812400953795;5129.410117836459;5132.153194722866;5132.717700526469;4113.568075352075;4159.334506478964;5087.135187018197;5099.260607211952;5116.8976620467565;4869.2939523768855;5012.598992080625;5082.923756143679;5091.236314552828;5111.4121875984365;4221.894452638678;4234.343676730112;4316.784160791948;4323.632491238249;4328.2209202343565;5281.313429254173;6666.200055993312;6672.0325552794575;6694.56485328457;6695.230048544431;4866.46468888422;6043.758249670008;6044.24446944132;6048.606840555394;6064.514838812928;7139.321764432422;7420.035395398563;7439;7443.106827180719;7467.738629147953;4868.488808675073;4871.147549178915;4875.073735990186;4877;4878.268259761065;6893.448524118108;7131.965864949553;7907.683692652287;7915.406344524126;7929.96035019827;4066.898327541776;4466.793965629262;4699.483056863743;4810.350602668665;4816.975915120402;4431.224535706238;4865.416150061945;4877.219644856877;4885.8045678173185;4890.364252647204;5288.550473209743;5496.835094947158;5907.320658124285;5913.881722365529;5945.286565612154;7200.811866042044;7464.738734144279;7471.178170401252;7485.251474852471;7529.623518824146;1509.9320530576151;1639.3114891745495;1689.8056723476711;1710.598009467774;1712.571857035741;1072.131573425528;1076.8761592416815;1080.114306268852;1082.767205050902;1093.9015488606065;6752.729890804411;7059.682314295869;7064.492105302544;7070.186928503185;7090.574565526085;6659.600423974577;7776.416768742254;7791.4156438267355;7798.220177982156;7810.297073263434;6819.795406137824;6972;7002.264762199896;7027.718891244395;7064.293570642894;3970.4838371011583;4070.3080476319096;4072.8778136655947;4079.673626109904;4110.856120035784;8083.151269116775;8106.716264930699;8146.714864979697;8150;8162.469439486415;7863.410244231705;8063.959680201561;8064.153263907323;8096.149904260085;8158.918410815934;7373.594452305175;7836.37309015266;8190.959045204855;8205.097439281673;8213.753587392388;5751.511121554715;7498;7853.725119620786;7864.056313242448;7864.370850332074;7442.06974128234;7686.884696729665;7689.192634773268;7708.344790692629;7731.613419329124;8163;8164.7958801030445;8173.264406203232;8177.059638141452;8200.26197642215;4694.6244300456565;4785.712857228577;4841.05599408112;4848.466668666514;4851.830185943475;6315.621062736251;7744.92255077442;7787.29914307715;7787.610619469117;7808.063032436144;7540.698372065056;7541.773746787605;7545.811354716176;7558.055243094614;7560.58416787082;6871;6918.688659010458;7314.378277846443;7531.548107113591;7551.848963020599;7356.963215184104;7365.742199023009;7368.115826100902;7377.889331659922;7388.445866559922;6325.304216536269;7013.193482749345;7349.4487913407775;7518.924810751822;7541.116325092472;6978.337057979484;7383.778486645409;7386.298301661333;7389.002484664501;7401.185869554452 16:13:59 INFO - 2015-11-19 16:13:59,691 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.9226077392261;794.9903622399553;795.6777505110432;824.1922915542764;840.8150206954475;14804.333804978774;15141.470048548303;15144.77282840757;15159.772603410931;15170.544883653494;14030.228337441436;14172.71654566908;14176;14191.78712319316;14201.78697319541;756.5611945071872;761.6762875777772;938.699616122841;962.4946902875976;963.585658166988;754.4944886925746;767.57399643198;769.2000319667567;772.0966469231013;773.6015951784835;1009.7273736091252;1024.9077583017527;1025.4770067265674;1025.6871654145482;1027.2141811514198;966.6326795817614;985.6845809341014;1008.4403156248279;1010.8635334229895;1011.3931641015332;592.5141384065068;593.2702775586054;600.909863520471;743.7434085240637;750.9812254693621;14553.272336383245;14639.63400914975;14667.706645867023;14704.779428308584;14771.33528991198;12091.153619246656;12271.877281227253;12329.568465103768;12704.983601311966;12773.552925647651;10265.178785697126;10273.589056437733;10298.433586152758;10437.895621043768;11056.723581910435;3490.7207423406066;3527.400341941876;3534.6288639692975;3535.840887160084;3547.6984456321243;75954.48091038148;77282;77384;79566.40867182682;84101.15898840994;9343.672971445967;9353.766155846159;9355.812883742423;9396.90603093974;9733.707988760349;21478.57042859134;21625.24311649116;21751.891240543697;21768.23811166633;21769.891150544147;7454.776356709307;7497.1753107158165;7524.209957954446;7537.623118844036;7729.420293478011;4132.834686612562;4140.44104045956;4158.8336466540995;4160.4591403118;4190.832366705297;3626.437902125175;3664.926701465956;3668.5781135169264;3672.6143754905884;3673.430618254175;631.835722712089;641.4355367276767;644.0371644391664;661.9900701489481;663.4990582110476;507.7207535855339;515.1885779896678;516.8036146264395;518.4426741253168;547.2366049361199;9110.635574576943;9709.27180461454;9745.463999480096;9768.462734549526;9787.119159275699;523.8245187862033;546.5764032874474;555.2060553408584;559.7900787204799;588.685053496386;4158.875233742992;4460.955390446119;4522.66080043998;4549.590536851633;4582.908341833145;99165.50417248011;100663;103846;105455;105983.47008265063;88775.11224887798;88912;89355;89517;90031;78312;78330.2166978323;78801.60599196967;78909.21090789133;79452.60273698595;9071.410358326688;9089;9098.681546145854;9145.496997665192;9199.724008279762;55161.44838551563;55332;55510.16734749063;55779.44220557905;56441;65608.67195663991;74353.07763068467;77824;78758;78785;11636.592719254786;11638.06895448379;11657.358845263592;11741.706457338634;12147.514099436277;12194.085443591588;12523.060770442435;12608.306543139848;12625.810612840998;13001.024923130992;11329.830052549054;11485.310881347146;11710.4730287139;11962.880371196177;12536.937315313366;11424.028957538701;11446.484908179318;11793.764124717629;11817.881821181678;12583.433745481658;11165.609203677832;11521.481533331187;11616.709582260512;11647.534098635959;12331.50673973031;8546.615402307036;9756.219502439646;9795.118439340493;10029.14752246038;10361.274710770174;9093.363464557417;9196.402233854778;9484.810303793747;10125.64560240388;10198.643047493302 16:13:59 INFO - 2015-11-19 16:13:59,691 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1268 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: __startTimestamp1447978439677__endTimestamp 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5912.23 Median:6146.14 stddev:656.52 (10.7%) stddev-sans-first:629.85 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: Values: 3465.8 3527.6 3543.3 3553.6 3593.1 5673.8 5769.9 5978.8 5992.2 5992.8 5121.4 5821.3 5822.9 5904.8 6123.4 5243.4 5319.4 5320.9 5321.9 5390.5 5412.5 5446.0 5463.3 5478.5 5500.7 5148.6 5252.7 5289.2 5376.9 5390.2 5300.5 5328.5 5330.2 5337.2 5337.3 5176.8 5214.9 5258.7 5267.9 5274.8 5803.2 5809.7 5871.7 5910.3 5918.8 6314.1 6391.8 6394.9 6395.4 6402.3 6209.3 6292.0 6416.3 6423.7 6429.1 5928.3 5956.0 5995.5 6045.5 6059.2 6495.2 6541.3 6581.1 6582.9 6589.4 6097.8 6241.2 6416.6 6435.6 6445.0 6314.3 6396.2 6452.3 6453.7 6467.1 6403.2 6412.3 6420.2 6430.2 6447.1 6126.5 6328.4 6392.6 6399.5 6408.3 4990.1 5014.4 5014.4 5111.4 5118.8 4518.9 4565.6 4571.1 4577.1 4602.1 5091.3 6061.6 6081.8 6096.2 6104.0 6256.4 6290.7 6344.8 6376.9 6410.2 6087.9 6091.0 6129.0 6146.1 6154.6 5610.9 5616.4 5625.1 5640.1 5647.7 6329.0 6363.8 6456.9 6460.4 6531.7 6333.6 6362.0 6369.4 6402.2 6407.6 6522.6 6536.1 6536.6 6541.8 6571.2 6082.1 6183.9 6239.9 6259.6 6417.9 6386.1 6399.7 6399.9 6412.9 6421.0 5817.9 6174.2 6338.6 6342.9 6348.9 5946.0 6173.4 6232.5 6262.7 6284.2 6176.8 6184.8 6242.2 6250.0 6267.5 6350.7 6364.1 6370.5 6379.7 6398.4 5900.8 6019.8 6129.6 6143.1 6233.5 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,692 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67955.96 Median:35373.82 stddev:145412.21 (411.1%) stddev-sans-first:145732.05 16:13:59 INFO - 2015-11-19 16:13:59,694 DEBUG : BROWSER_OUTPUT: Values: 549.2 556.0 566.9 640.2 647.7 31868.0 39401.4 39611.0 39646.0 39654.8 42851.6 43241.8 43353.8 43442.0 43466.0 8871.0 8988.8 9774.4 9991.1 10013.5 8867.7 11874.2 12031.2 12045.6 12092.6 11747.8 11857.1 11857.8 11862.6 11891.7 9019.1 9093.1 9174.5 11625.7 11765.2 8843.5 8943.5 11997.0 12117.7 12126.5 40209.2 40377.6 40390.4 40540.0 40644.4 3183.2 3187.2 3259.4 3489.2 3493.6 29401.7 29605.0 29643.7 29670.7 29930.3 2421.9 2776.8 2801.0 2819.7 2831.2 469554.0 472072.0 472151.0 472707.0 473014.6 58321.7 59306.7 59313.0 59391.0 59594.0 70543.0 71332.0 71601.0 71715.6 71861.3 16183.4 16675.3 16683.7 16691.4 16750.9 12653.0 12683.1 12723.6 12905.5 12926.2 20050.5 20535.6 20617.8 20623.0 20665.9 9219.9 9474.9 9492.0 9492.7 9567.2 904.5 957.9 997.5 1055.6 1060.0 24982.3 29242.4 29650.6 30222.4 30331.5 1044.1 1062.7 1081.6 1159.7 1207.5 14502.8 14659.0 14686.0 14713.3 14839.7 535186.0 535947.0 536301.0 536476.0 538330.0 57288.0 57564.7 57633.1 57747.4 57809.4 1328.7 1354.3 1454.9 1470.7 1480.1 24936.0 28773.6 29579.4 30443.7 30507.4 49615.5 53188.7 53437.0 53452.5 53568.5 437622.4 651972.0 653675.0 654485.0 655217.0 30458.0 31290.1 31299.4 31349.8 31674.7 43503.6 43955.1 44130.6 44518.0 45442.5 36995.8 37382.6 37906.2 38123.2 38180.6 35754.3 36835.6 36956.3 37063.0 37074.8 31980.8 34265.8 35361.0 35386.6 35488.3 28795.4 32571.7 32691.5 32774.3 32808.7 19515.9 23050.6 24227.4 24390.5 24925.5 16:13:59 INFO - 2015-11-19 16:13:59,694 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,694 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38154.06 Median:11389.00 stddev:114991.02 (1009.7%) stddev-sans-first:115278.58 16:13:59 INFO - 2015-11-19 16:13:59,695 DEBUG : BROWSER_OUTPUT: Values: 359.2 362.9 365.7 367.8 372.7 12830.6 17152.6 20097.7 21303.9 21624.0 21111.6 21142.8 21479.1 21637.1 21655.8 4728.2 6443.4 6610.5 6621.1 6622.0 4823.7 4880.4 7416.9 7627.0 7638.0 4778.6 5912.1 5934.6 7528.3 7604.1 5811.2 5868.5 5869.6 5871.4 5890.5 5479.8 5620.4 5638.2 5650.7 5658.0 25012.5 25042.0 25179.9 25550.6 25752.6 2017.3 2050.2 2129.0 2131.9 2175.4 9721.9 9943.9 10055.6 12564.9 13755.7 1644.2 1712.8 1744.6 1762.8 1785.8 99333.5 104007.9 104411.0 105469.5 106007.0 10934.1 10955.8 10956.6 10964.6 11010.2 13007.2 13108.3 13115.1 13119.9 13126.7 8544.2 8594.4 8594.7 8623.0 8639.5 8758.3 8765.0 8791.3 8809.5 8852.5 4012.9 4169.3 4175.2 4218.5 4286.9 1453.7 1535.7 1731.5 1758.3 1764.9 888.9 895.7 928.5 993.7 1014.8 17048.5 20073.0 20727.8 20780.2 20829.2 969.2 979.1 1019.2 1048.8 1056.9 10669.3 10837.4 10854.3 10855.2 10876.7 683619.0 691651.0 703074.0 708419.0 708859.0 102854.0 104655.5 106386.5 109538.0 120913.0 1147.9 1157.5 1167.9 1179.7 1181.5 18133.8 18261.8 18417.8 18447.1 18482.4 51529.2 52037.8 52246.7 52507.9 52961.7 57945.7 80732.0 80766.8 83705.0 90443.0 15650.5 16215.0 16805.6 16855.7 16917.4 16984.8 19701.5 20457.9 21140.8 21330.9 13840.8 15476.3 16678.8 16823.8 17269.1 16709.2 16991.4 17077.5 17307.1 17310.5 17808.3 17964.0 18400.0 18500.9 18702.8 12095.0 12694.4 16551.8 16910.7 17206.2 16706.7 16846.3 17388.1 17435.0 17475.7 16:13:59 INFO - 2015-11-19 16:13:59,695 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,696 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5806.62 Median:6171.70 stddev:2997.63 (48.6%) stddev-sans-first:2987.84 16:13:59 INFO - 2015-11-19 16:13:59,696 DEBUG : BROWSER_OUTPUT: Values: 1413.1 1535.8 1543.2 1890.6 1902.2 7668.4 7943.1 7972.0 7972.3 7981.0 7750.1 8179.7 8320.3 8325.0 8329.8 2328.3 2402.4 2404.1 2405.3 2420.8 2370.9 2408.0 2437.3 2437.9 2445.4 2305.9 2370.0 2397.4 2409.0 2410.4 2348.1 2366.6 2398.6 2402.6 2403.2 2370.9 2391.1 2413.8 2424.6 2432.6 8368.5 8459.6 8465.5 8470.4 8472.7 4711.4 5101.2 5198.9 5206.1 5247.7 2964.9 3204.4 3225.7 3355.8 3466.2 922.3 1033.1 1057.5 1062.1 1063.2 11078.5 11107.3 11122.5 11140.1 11174.3 4673.6 4742.4 4777.5 4786.8 4802.3 9598.1 9609.6 9636.7 9643.3 9650.2 5224.4 5255.8 5266.4 5275.4 5296.2 4823.0 4826.1 4828.7 4831.6 4835.3 3663.9 3674.6 3679.0 3685.4 3710.6 1140.2 1150.9 1152.3 1169.0 1170.8 1110.6 1115.4 1162.1 1312.5 1424.9 7861.1 7866.3 7947.6 7958.2 7968.5 1141.9 1159.4 1200.4 1205.2 1205.8 5912.2 6210.0 6251.3 6268.5 6288.1 8867.5 9741.2 10095.4 10095.9 10121.4 9893.8 9983.7 9994.1 10004.8 10065.6 7818.6 7866.3 7911.3 7990.2 7999.4 6210.4 7697.3 7735.8 7772.0 7836.4 9024.0 9077.0 9128.2 9164.2 9205.5 9010.9 9192.4 9331.3 9504.6 9518.2 6133.4 7226.9 7330.9 7339.5 7361.3 7830.3 7924.2 7930.5 7940.6 7941.8 7318.5 7416.5 7442.9 7502.6 7595.5 7341.7 7351.5 7441.8 7467.2 7474.4 7318.5 7462.1 7480.0 7491.0 7499.0 6802.9 6836.7 6838.3 6843.8 6850.3 6747.2 6816.6 6855.3 6856.7 6862.2 16:13:59 INFO - 2015-11-19 16:13:59,696 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,696 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6039.19 Median:6971.22 stddev:1992.19 (28.6%) stddev-sans-first:1950.65 16:13:59 INFO - 2015-11-19 16:13:59,698 DEBUG : BROWSER_OUTPUT: Values: 300.3 321.3 324.6 330.8 335.2 6894.8 7073.6 7075.6 7079.9 7087.9 6970.4 6981.7 6981.7 6984.1 7008.6 4297.6 4924.2 4979.4 5028.3 5050.7 4891.2 4962.2 5129.4 5132.2 5132.7 4113.6 4159.3 5087.1 5099.3 5116.9 4869.3 5012.6 5082.9 5091.2 5111.4 4221.9 4234.3 4316.8 4323.6 4328.2 5281.3 6666.2 6672.0 6694.6 6695.2 4866.5 6043.8 6044.2 6048.6 6064.5 7139.3 7420.0 7439.0 7443.1 7467.7 4868.5 4871.1 4875.1 4877.0 4878.3 6893.4 7132.0 7907.7 7915.4 7930.0 4066.9 4466.8 4699.5 4810.4 4817.0 4431.2 4865.4 4877.2 4885.8 4890.4 5288.6 5496.8 5907.3 5913.9 5945.3 7200.8 7464.7 7471.2 7485.3 7529.6 1509.9 1639.3 1689.8 1710.6 1712.6 1072.1 1076.9 1080.1 1082.8 1093.9 6752.7 7059.7 7064.5 7070.2 7090.6 6659.6 7776.4 7791.4 7798.2 7810.3 6819.8 6972.0 7002.3 7027.7 7064.3 3970.5 4070.3 4072.9 4079.7 4110.9 8083.2 8106.7 8146.7 8150.0 8162.5 7863.4 8064.0 8064.2 8096.1 8158.9 7373.6 7836.4 8191.0 8205.1 8213.8 5751.5 7498.0 7853.7 7864.1 7864.4 7442.1 7686.9 7689.2 7708.3 7731.6 8163.0 8164.8 8173.3 8177.1 8200.3 4694.6 4785.7 4841.1 4848.5 4851.8 6315.6 7744.9 7787.3 7787.6 7808.1 7540.7 7541.8 7545.8 7558.1 7560.6 6871.0 6918.7 7314.4 7531.5 7551.8 7357.0 7365.7 7368.1 7377.9 7388.4 6325.3 7013.2 7349.4 7518.9 7541.1 6978.3 7383.8 7386.3 7389.0 7401.2 16:13:59 INFO - 2015-11-19 16:13:59,698 DEBUG : BROWSER_OUTPUT: 16:13:59 INFO - 2015-11-19 16:13:59,698 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19624.52 Median:2545.31 stddev:28258.71 (1110.2%) stddev-sans-first:28302.53 16:13:59 INFO - 2015-11-19 16:13:59,699 DEBUG : BROWSER_OUTPUT: Values: 773.9 795.0 795.7 824.2 840.8 14804.3 15141.5 15144.8 15159.8 15170.5 14030.2 14172.7 14176.0 14191.8 14201.8 756.6 761.7 938.7 962.5 963.6 754.5 767.6 769.2 772.1 773.6 1009.7 1024.9 1025.5 1025.7 1027.2 966.6 985.7 1008.4 1010.9 1011.4 592.5 593.3 600.9 743.7 751.0 14553.3 14639.6 14667.7 14704.8 14771.3 12091.2 12271.9 12329.6 12705.0 12773.6 10265.2 10273.6 10298.4 10437.9 11056.7 3490.7 3527.4 3534.6 3535.8 3547.7 75954.5 77282.0 77384.0 79566.4 84101.2 9343.7 9353.8 9355.8 9396.9 9733.7 21478.6 21625.2 21751.9 21768.2 21769.9 7454.8 7497.2 7524.2 7537.6 7729.4 4132.8 4140.4 4158.8 4160.5 4190.8 3626.4 3664.9 3668.6 3672.6 3673.4 631.8 641.4 644.0 662.0 663.5 507.7 515.2 516.8 518.4 547.2 9110.6 9709.3 9745.5 9768.5 9787.1 523.8 546.6 555.2 559.8 588.7 4158.9 4461.0 4522.7 4549.6 4582.9 99165.5 100663.0 103846.0 105455.0 105983.5 88775.1 88912.0 89355.0 89517.0 90031.0 78312.0 78330.2 78801.6 78909.2 79452.6 9071.4 9089.0 9098.7 9145.5 9199.7 55161.4 55332.0 55510.2 55779.4 56441.0 65608.7 74353.1 77824.0 78758.0 78785.0 11636.6 11638.1 11657.4 11741.7 12147.5 12194.1 12523.1 12608.3 12625.8 13001.0 11329.8 11485.3 11710.5 11962.9 12536.9 11424.0 11446.5 11793.8 11817.9 12583.4 11165.6 11521.5 11616.7 11647.5 12331.5 8546.6 9756.2 9795.1 10029.1 10361.3 9093.4 9196.4 9484.8 10125.6 10198.6 16:13:59 INFO - 2015-11-19 16:13:59,699 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:13:59 INFO - 2015-11-19 16:13:59,699 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-19 16:14:00,145 INFO : Browser exited with error code: 0 16:14:00 INFO - 2015-11-19 16:14:00,170 INFO : Completed test dromaeo_css (00:18:34) 16:14:00 INFO - 2015-11-19 16:14:00,170 INFO : Starting test kraken 16:14:00 INFO - 2015-11-19 16:14:00,170 DEBUG : operating with platform_type : mac_ 16:14:00 INFO - 2015-11-19 16:14:00,170 INFO : Initialising browser for kraken test... 16:14:00 INFO - 2015-11-19 16:14:00,182 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpEU67A8/profile http://localhost:49259/getInfo.html 16:14:02 INFO - 2015-11-19 16:14:02,302 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:14:02 INFO - 2015-11-19 16:14:02,302 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:14:02 INFO - 2015-11-19 16:14:02,302 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:14:02 INFO - 2015-11-19 16:14:02,302 DEBUG : BROWSER_OUTPUT: __metrics 16:14:02 INFO - 2015-11-19 16:14:02,318 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:02 INFO - 2015-11-19 16:14:02,576 DEBUG : BROWSER_OUTPUT: console.error: 16:14:02 INFO - 2015-11-19 16:14:02,577 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 16:14:02 INFO - 2015-11-19 16:14:02,577 DEBUG : BROWSER_OUTPUT: Stack: 16:14:02 INFO - 2015-11-19 16:14:02,578 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 16:14:02 INFO - 2015-11-19 16:14:02,578 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 16:14:02 INFO - 2015-11-19 16:14:02,579 DEBUG : BROWSER_OUTPUT: 16:14:02 INFO - 2015-11-19 16:14:02,945 INFO : Browser initialized. 16:14:02 INFO - 2015-11-19 16:14:02,946 INFO : Running cycle 1/1 for kraken test... 16:14:02 INFO - 2015-11-19 16:14:02,946 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpEU67A8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:14:14 INFO - 2015-11-19 16:14:14,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 226181120 16:14:14 INFO - 2015-11-19 16:14:14,711 DEBUG : BROWSER_OUTPUT: 16:14:17 INFO - 2015-11-19 16:14:17,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:17 INFO - 2015-11-19 16:14:17,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 275402752 16:14:17 INFO - 2015-11-19 16:14:17,814 DEBUG : BROWSER_OUTPUT: 16:14:20 INFO - 2015-11-19 16:14:20,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-dft) 16:14:20 INFO - 2015-11-19 16:14:20,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 291360768 16:14:20 INFO - 2015-11-19 16:14:20,918 DEBUG : BROWSER_OUTPUT: 16:14:24 INFO - 2015-11-19 16:14:24,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-fft) 16:14:24 INFO - 2015-11-19 16:14:24,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 276684800 16:14:24 INFO - 2015-11-19 16:14:24,689 DEBUG : BROWSER_OUTPUT: 16:14:26 INFO - 2015-11-19 16:14:26,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator) 16:14:27 INFO - 2015-11-19 16:14:27,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 278446080 16:14:27 INFO - 2015-11-19 16:14:27,120 DEBUG : BROWSER_OUTPUT: 16:14:29 INFO - 2015-11-19 16:14:29,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:29 INFO - 2015-11-19 16:14:29,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 280350720 16:14:29 INFO - 2015-11-19 16:14:29,838 DEBUG : BROWSER_OUTPUT: 16:14:32 INFO - 2015-11-19 16:14:32,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:33 INFO - 2015-11-19 16:14:33,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 281743360 16:14:33 INFO - 2015-11-19 16:14:33,090 DEBUG : BROWSER_OUTPUT: 16:14:35 INFO - 2015-11-19 16:14:35,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:36 INFO - 2015-11-19 16:14:36,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 281534464 16:14:36 INFO - 2015-11-19 16:14:36,527 DEBUG : BROWSER_OUTPUT: 16:14:39 INFO - 2015-11-19 16:14:39,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial) 16:14:39 INFO - 2015-11-19 16:14:39,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 281509888 16:14:39 INFO - 2015-11-19 16:14:39,907 DEBUG : BROWSER_OUTPUT: 16:14:41 INFO - 2015-11-19 16:14:41,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:42 INFO - 2015-11-19 16:14:42,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 312692736 16:14:42 INFO - 2015-11-19 16:14:42,015 DEBUG : BROWSER_OUTPUT: 16:14:43 INFO - 2015-11-19 16:14:43,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:44 INFO - 2015-11-19 16:14:44,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 313995264 16:14:44 INFO - 2015-11-19 16:14:44,401 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-11-19 16:14:46,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:47 INFO - 2015-11-19 16:14:47,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 324210688 16:14:47 INFO - 2015-11-19 16:14:47,022 DEBUG : BROWSER_OUTPUT: 16:14:49 INFO - 2015-11-19 16:14:49,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:50 INFO - 2015-11-19 16:14:50,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 324313088 16:14:50 INFO - 2015-11-19 16:14:50,201 DEBUG : BROWSER_OUTPUT: 16:14:52 INFO - 2015-11-19 16:14:52,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:53 INFO - 2015-11-19 16:14:53,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 323735552 16:14:53 INFO - 2015-11-19 16:14:53,243 DEBUG : BROWSER_OUTPUT: 16:14:54 INFO - 2015-11-19 16:14:54,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49259/tests/kraken/driver.html?testName=ai-astar) 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 383950848 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;108;104;109;110;110;108;109;101;109 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;118;140;153;117;140;138;118;156;116 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;185;182;185;184;184;183;182;184;185 16:14:55 INFO - 2015-11-19 16:14:55,180 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;70;73;71;55;56;57;70;71;56 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;82;118;82;106;111;135;74;76;111 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;86;86;86;85;85;87;85;84;85 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;94;94;97;88;131;118;94;93 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;90;92;89;85;87;88;89;87;96;133 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;53;53;54;54;55;53;63;51;60 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;64;66;66;66;67;68 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;81;83;82;83;82;84;81;83;82 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;123;126;119;128;129;147;125;124;127 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;133;130;132;130;121;117;138;170;153 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;64;65;65;66;68;91;63;65 16:14:55 INFO - 2015-11-19 16:14:55,181 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:14:55 INFO - 2015-11-19 16:14:55,182 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:14:55 INFO - 2015-11-19 16:14:55,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1069 16:14:55 INFO - 2015-11-19 16:14:55,182 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:14:55 INFO - 2015-11-19 16:14:55,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1447978495179__endTimestamp 16:14:55 INFO - 2015-11-19 16:14:55,182 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,183 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:14:55 INFO - 2015-11-19 16:14:55,183 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:14:55 INFO - 2015-11-19 16:14:55,183 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,183 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:2.91 (2.7%) stddev-sans-first:3.05 16:14:55 INFO - 2015-11-19 16:14:55,183 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 104.0 109.0 110.0 110.0 108.0 109.0 101.0 109.0 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:134.20 Median:140.00 stddev:15.64 (11.2%) stddev-sans-first:16.00 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: Values: 146.0 118.0 140.0 153.0 117.0 140.0 138.0 118.0 156.0 116.0 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.16 (0.6%) stddev-sans-first:1.20 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: Values: 183.0 185.0 182.0 185.0 184.0 184.0 183.0 182.0 184.0 185.0 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.10 Median:70.00 stddev:7.55 (10.8%) stddev-sans-first:7.97 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: Values: 62.0 70.0 73.0 71.0 55.0 56.0 57.0 70.0 71.0 56.0 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.10 Median:75.00 stddev:20.78 (27.7%) stddev-sans-first:21.58 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: Values: 86.0 82.0 118.0 82.0 106.0 111.0 135.0 74.0 76.0 111.0 16:14:55 INFO - 2015-11-19 16:14:55,184 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,185 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 16:14:55 INFO - 2015-11-19 16:14:55,185 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 86.0 86.0 85.0 85.0 87.0 85.0 84.0 85.0 16:14:55 INFO - 2015-11-19 16:14:55,185 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.50 stddev:13.71 (14.7%) stddev-sans-first:14.33 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 94.0 94.0 97.0 88.0 131.0 118.0 94.0 93.0 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:93.60 Median:89.00 stddev:14.18 (15.9%) stddev-sans-first:14.97 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 89.0 85.0 87.0 88.0 89.0 87.0 96.0 133.0 16:14:55 INFO - 2015-11-19 16:14:55,186 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.63 (6.7%) stddev-sans-first:3.86 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: Values: 55.0 53.0 53.0 54.0 54.0 55.0 53.0 63.0 51.0 60.0 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.42 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 64.0 66.0 66.0 66.0 67.0 68.0 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.08 (1.3%) stddev-sans-first:1.00 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: Values: 84.0 81.0 83.0 82.0 83.0 82.0 84.0 81.0 83.0 82.0 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:7.44 (5.8%) stddev-sans-first:7.88 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: Values: 129.0 123.0 126.0 119.0 128.0 129.0 147.0 125.0 124.0 127.0 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,187 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:133.00 stddev:15.42 (11.6%) stddev-sans-first:16.32 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: Values: 133.0 133.0 130.0 132.0 130.0 121.0 117.0 138.0 170.0 153.0 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:65.00 stddev:8.33 (12.8%) stddev-sans-first:8.73 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 65.0 66.0 68.0 91.0 63.0 65.0 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:14:55 INFO - 2015-11-19 16:14:55,188 DEBUG : BROWSER_OUTPUT: 16:14:55 INFO - 2015-11-19 16:14:55,806 INFO : Browser exited with error code: 0 16:14:55 INFO - 2015-11-19 16:14:55,851 INFO : Completed test kraken (00:00:55) 16:14:55 INFO - 2015-11-19 16:14:55,851 INFO : Starting test v8_7 16:14:55 INFO - 2015-11-19 16:14:55,851 DEBUG : operating with platform_type : mac_ 16:14:55 INFO - 2015-11-19 16:14:55,851 INFO : Initialising browser for v8_7 test... 16:14:55 INFO - 2015-11-19 16:14:55,863 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpgVJmP_/profile http://localhost:49259/getInfo.html 16:14:57 INFO - 2015-11-19 16:14:57,691 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:14:57 INFO - 2015-11-19 16:14:57,691 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:14:57 INFO - 2015-11-19 16:14:57,691 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:14:57 INFO - 2015-11-19 16:14:57,691 DEBUG : BROWSER_OUTPUT: __metrics 16:14:57 INFO - 2015-11-19 16:14:57,707 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:58 INFO - 2015-11-19 16:14:58,328 INFO : Browser initialized. 16:14:58 INFO - 2015-11-19 16:14:58,328 INFO : Running cycle 1/1 for v8_7 test... 16:14:58 INFO - 2015-11-19 16:14:58,329 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpgVJmP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:15:10 INFO - 2015-11-19 16:15:10,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 226013184 16:15:10 INFO - 2015-11-19 16:15:10,174 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49259/tests/v8_7/run.html (next: http://localhost:49259/tests/v8_7/run.html) 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 305049600 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: |0;Richards;147.5796930342385 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.92323684631376 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: |2;Encrypt;310.2699348433137 16:15:31 INFO - 2015-11-19 16:15:31,882 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4686.915887850468 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1700.6802721088436 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |6;Boyer;13171.052631578947 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |8;Splay;677.5067750677507 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4502.242152466368 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: __startTimestamp1447978531881__endTimestamp 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,883 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:15:31 INFO - 2015-11-19 16:15:31,884 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:15:31 INFO - 2015-11-19 16:15:31,884 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.58 Median:147.58 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: Values: 147.6 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.92 Median:159.92 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: Values: 159.9 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:310.27 Median:310.27 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: Values: 310.3 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4686.92 Median:4686.92 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: Values: 4686.9 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1700.68 Median:1700.68 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: Values: 1700.7 16:15:31 INFO - 2015-11-19 16:15:31,885 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: Values: 785.5 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13171.05 Median:13171.05 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: Values: 13171.1 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: Values: 27027.0 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.51 Median:677.51 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: Values: 677.5 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4502.24 Median:4502.24 stddev:0.00 (0.0%) 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: Values: 4502.2 16:15:31 INFO - 2015-11-19 16:15:31,886 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:15:31 INFO - 2015-11-19 16:15:31,887 DEBUG : BROWSER_OUTPUT: 16:15:32 INFO - 2015-11-19 16:15:32,481 INFO : Browser exited with error code: 0 16:15:32 INFO - 2015-11-19 16:15:32,499 INFO : Completed test v8_7 (00:00:36) 16:15:32 INFO - 2015-11-19 16:15:32,944 INFO : Completed test suite (00:20:07) 16:15:32 INFO - 2015-11-19 16:15:32,944 DEBUG : Working with test: dromaeo_css 16:15:32 INFO - 2015-11-19 16:15:32,944 DEBUG : Generating results file: dromaeo_css 16:15:32 INFO - 2015-11-19 16:15:32,945 DEBUG : Working with test: kraken 16:15:32 INFO - 2015-11-19 16:15:32,945 DEBUG : Generating results file: kraken 16:15:32 INFO - 2015-11-19 16:15:32,945 INFO : javascript benchmark 16:15:32 INFO - 2015-11-19 16:15:32,945 DEBUG : Working with test: v8_7 16:15:32 INFO - 2015-11-19 16:15:32,946 DEBUG : Generating results file: v8_7 16:15:32 INFO - 2015-11-19 16:15:32,946 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:33 INFO - 2015-11-19 16:15:33,006 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 16:15:33 INFO - 2015-11-19 16:15:33,007 DEBUG : process_Request line: dromaeo_css 7812.53 graph.html#tests=[[72,1,59]] 16:15:33 INFO - 2015-11-19 16:15:33,007 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:33 INFO - 2015-11-19 16:15:33,037 DEBUG : process_Request line: kraken 1400.40 graph.html#tests=[[232,1,59]] 16:15:33 INFO - 2015-11-19 16:15:33,037 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:33 INFO - 2015-11-19 16:15:33,063 DEBUG : process_Request line: v8_7 20405.71 graph.html#tests=[[230,1,59]] 16:15:33 INFO - 2015-11-19 16:15:33,064 INFO : javascript benchmark 16:15:33 INFO - 2015-11-19 16:15:33,065 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3465.792052476851, 3527.5990031560104, 3543.2736289060713, 3553.5913369962464, 3593.119685677009, 5673.773049078032, 5769.942300577003, 5978.820635380935, 5992.191054207675, 5992.82021539354, 5121.359830021247, 5821.301443826736, 5822.912656310159, 5904.822855314347, 6123.357047510003, 5243.423223445437, 5319.361676598814, 5320.866978325554, 5321.946780532184, 5390.51485366317, 5412.539934105586, 5445.9727701361635, 5463.344398672165, 5478.534324582395, 5500.724963751816, 5148.613853960968, 5252.737363131828, 5289.153735402356, 5376.865578360533, 5390.164524498709, 5300.469953004707, 5328.49379308965, 5330.200469929503, 5337.199420086979, 5337.2794672719465, 5176.844694659167, 5214.8696282592855, 5258.658187217857, 5267.947320526784, 5274.7626356814035, 5803.187553742479, 5809.651420914759, 5871.706414679292, 5910.349861515273, 5918.792842250544, 6314.0844577536, 6391.8402039948905, 6394.9360506394805, 6395.42441180296, 6402.263739669905, 6209.254889413254, 6292.0, 6416.262129855079, 6423.7430502779835, 6429.099926010363, 5928.347881733006, 5955.987482128048, 5995.490383317423, 6045.455908968214, 6059.21230240066, 6495.188101487314, 6541.313162118005, 6581.111549940792, 6582.934170658328, 6589.406953374123, 6097.796915383809, 6241.188645476059, 6416.647084410402, 6435.613863168225, 6445.0, 6314.273858506239, 6396.232452105777, 6452.290248072803, 6453.741850326029, 6467.094606755058, 6403.231612206472, 6412.2625898022325, 6420.1974753155855, 6430.196225471816, 6447.065175549519, 6126.527406317373, 6328.367163283727, 6392.648404337713, 6399.456046236122, 6408.327125651833, 4990.126727822617, 5014.373203349582, 5014.398272207359, 5111.386633603991, 5118.769655365518, 4518.88702782433, 4565.56627120423, 4571.131485017836, 4577.130345234395, 4602.148602508547, 5091.3126727892, 6061.605995610271, 6081.75672973085, 6096.237970253718, 6103.969480152571, 6256.436920677161, 6290.654014029273, 6344.777932772331, 6376.904346434807, 6410.1987251593555, 6087.878242435127, 6091.0, 6128.9693551531955, 6146.139540464339, 6154.630722156685, 5610.943890561124, 5616.410276920946, 5625.128105143709, 5640.125780504029, 5647.6893770843, 6328.968355158287, 6363.840903977438, 6456.903146452807, 6460.35396460369, 6531.673416329069, 6333.556651034383, 6361.9502782040445, 6369.394907483782, 6402.199725034371, 6407.583507072025, 6522.641254731036, 6536.084948107174, 6536.575122617015, 6541.771038013647, 6571.178602674666, 6082.087686846831, 6183.876322473615, 6239.875202495834, 6259.624422534663, 6417.903731443938, 6386.074019267087, 6399.7440102395385, 6399.904001440075, 6412.871742565216, 6421.036844473367, 5817.894600025981, 6174.197354343906, 6338.619682819046, 6342.90485642725, 6348.93651063502, 5946.0, 6173.41352571505, 6232.501399888089, 6262.68686565679, 6284.183056202664, 6176.845578860564, 6184.752609895554, 6242.219722534684, 6249.96875015622, 6267.498600111889, 6350.7459701611415, 6364.109024736633, 6370.522210834299, 6379.744810207725, 6398.392152745481, 5900.819836032725, 6019.789307374396, 6129.570930035033, 6143.078538219303, 6233.501319894488], "unit": "ms", "name": "dojo.html", "value": 5870.788277958519}, {"lowerIsBetter": false, "replicates": [549.1914408661308, 555.9861003474911, 566.8866226754649, 640.1517988665017, 647.6793986976446, 31868.043958681217, 39401.40897886534, 39611.0, 39645.99999999996, 39654.810355689304, 42851.571484285145, 43241.78379108108, 43353.78323108388, 43442.004169520515, 43466.0, 8871.0, 8988.77528061797, 9774.413535187912, 9991.100800927916, 10013.49932503372, 8867.68963086292, 11874.16880818343, 12031.217970831867, 12045.578404755835, 12092.576759813408, 11747.765044699101, 11857.110716696283, 11857.822132668018, 11862.644120676394, 11891.702707432298, 9019.143181397756, 9093.136152065543, 9174.495402752846, 11625.6512304631, 11765.235259708092, 8843.513606751627, 8943.50810705411, 11997.040236781037, 12117.697057573543, 12126.454309556091, 40209.19581608351, 40377.596224037974, 40390.39414408786, 40540.0, 40644.39033414501, 3183.220111072802, 3187.2031992002, 3259.3970115528705, 3489.1974845785358, 3493.63316851732, 29401.70598294011, 29605.0, 29643.70356296431, 29670.703292967224, 29930.251743706365, 2421.9152329668377, 2776.7917406194615, 2800.9719902800916, 2819.675737290197, 2831.1506548035713, 469554.0, 472072.0, 472151.0, 472707.0, 473014.6349268266, 58321.708391457774, 59306.70346648325, 59313.0, 59391.0, 59594.0, 70543.0, 71332.0, 71601.0, 71715.64142179256, 71861.28138718651, 16183.43357982465, 16675.332986680638, 16683.6663266734, 16691.415800446925, 16750.916245418695, 12653.0, 12683.112182147346, 12723.618291451272, 12905.483780648856, 12926.159799613182, 20050.498737531387, 20535.589288214152, 20617.793822061587, 20623.0, 20665.89667051655, 9219.861702074475, 9474.900628604899, 9491.952540237255, 9492.667756628485, 9567.234621230285, 904.5115637555647, 957.9425234485954, 997.4563862694848, 1055.6094245129352, 1060.0194819791816, 24982.250532484053, 29242.41515169685, 29650.55524167139, 30222.395552088834, 30331.545026824617, 1044.1385856668278, 1062.7236918401272, 1081.6322450366756, 1159.7448561316496, 1207.5049229815734, 14502.782458263135, 14659.0, 14685.97198196116, 14713.337899794535, 14839.70320593582, 535186.0, 535947.0, 536301.0, 536476.0, 538330.0, 57288.0, 57564.71217643885, 57633.13550296749, 57747.422525775044, 57809.421905781244, 1328.7010422654826, 1354.2619272496513, 1454.9490767823074, 1470.669099452636, 1480.1193289992436, 24936.0, 28773.56839647449, 29579.408411831213, 30443.695563044974, 30507.389852203276, 49615.503844962535, 53188.73405632947, 53437.0, 53452.46547534475, 53568.46431535791, 437622.36643434654, 651972.0, 653675.0, 654485.0, 655217.0, 30458.0, 31290.06129816109, 31299.37401252008, 31349.843250784514, 31674.683253168096, 43503.56496434995, 43955.120897581226, 44130.55869441265, 44518.0, 45442.545574545155, 36995.815020924725, 37382.626173739, 37906.241875162894, 38123.2375352497, 38180.6181938177, 35754.284914301046, 36835.63164368322, 36956.26087478289, 37063.0, 37074.814625926694, 31980.840095800304, 34265.82867085748, 35361.0, 35386.646133538336, 35488.29023419569, 28795.42409151847, 32571.674283256863, 32691.509627356085, 32774.34451310913, 32808.67191328056, 19515.902420487808, 23050.616962982276, 24227.39431514226, 24390.51218975575, 24925.501489970462], "unit": "ms", "name": "ext.html", "value": 20285.914526515106}, {"lowerIsBetter": false, "replicates": [359.19002649026424, 362.8947605194493, 365.71291536144133, 367.81793012458826, 372.68508110646496, 12830.615081547545, 17152.571185720364, 20097.693649912744, 21303.934803259854, 21624.026918788673, 21111.577768444622, 21142.788572114274, 21479.140834366644, 21637.07899433576, 21655.783442165575, 4728.196206644879, 6443.387878151568, 6610.537262391635, 6621.139251897247, 6621.966890165542, 4823.734694591796, 4880.414350277972, 7416.851662966737, 7626.961865190667, 7637.961810190941, 4778.641601879855, 5912.054071348585, 5934.614250073753, 7528.322450979438, 7604.125525564548, 5811.215485909412, 5868.471837534642, 5869.618474799125, 5871.383504731984, 5890.499307558863, 5479.808206712746, 5620.353659329188, 5638.154276858463, 5650.745716442729, 5657.981563318601, 25012.4997500049, 25042.0, 25179.866905989275, 25550.61674074872, 25752.613710794354, 2017.273781438681, 2050.1799280287855, 2129.0419311309815, 2131.872087674729, 2175.445261458318, 9721.854172187423, 9943.90056099437, 10055.597776088947, 12564.869161775485, 13755.656108597264, 1644.1861278667018, 1712.8115907250192, 1744.5813004878864, 1762.7620271263472, 1785.803561608222, 99333.5033324836, 104007.9198416035, 104411.0, 105469.472652637, 106007.0, 10934.125269978382, 10955.780884382268, 10956.616518421977, 10964.616238431776, 11010.174236932102, 13007.219566826021, 13108.344582770824, 13115.081944264, 13119.934400327937, 13126.671833204055, 8544.2310192083, 8594.398392112616, 8594.699185528601, 8623.0, 8639.481631102153, 8758.343124265706, 8765.0, 8791.340649451316, 8809.471431714117, 8852.468851868909, 4012.9398059029136, 4169.3120635094865, 4175.248455278079, 4218.472690913636, 4286.935695964563, 1453.694724107928, 1535.7389243828577, 1731.4892106828515, 1758.3494107180425, 1764.9294028238726, 888.8844450221429, 895.7312806158257, 928.4522131942186, 993.6919554937992, 1014.771676372825, 17048.48854534366, 20073.0, 20727.829936760147, 20780.206284384916, 20829.1668333268, 969.1568335548118, 979.0552117206929, 1019.2457581389718, 1048.8253156464655, 1056.8995945385177, 10669.253152279422, 10837.403942783065, 10854.294470859526, 10855.240133190759, 10876.72808179786, 683619.0, 691651.0, 703074.0, 708419.0, 708859.0, 102854.0, 104655.4767226159, 106386.46806765917, 109538.0, 120913.0, 1147.8794726553758, 1157.5196293538256, 1167.9240849344765, 1179.6755892129734, 1181.4565299961941, 18133.81866181374, 18261.81738182601, 18417.802842815174, 18447.07764611791, 18482.445526634223, 51529.22706159486, 52037.79508783182, 52246.73876630593, 52507.94984100373, 52961.73519132534, 57945.71027144837, 80732.0, 80766.78849817374, 83705.0, 90443.0, 15650.45223417175, 16215.0, 16805.579860503585, 16855.747163792308, 16917.40789072426, 16984.830151698818, 19701.507462313555, 20457.874816885214, 21140.78859211388, 21330.933453327583, 13840.792388113985, 15476.303566339317, 16678.834835730104, 16823.831761682228, 17269.050202239, 16709.2480838365, 16991.40530081441, 17077.487675369262, 17307.134643268037, 17310.480685579452, 17808.287668493635, 17964.0, 18399.98800066009, 18500.889946603245, 18702.81297187065, 12095.0, 12694.365281735692, 16551.83448165503, 16910.66178676395, 17206.22571984289, 16706.66586668284, 16846.326146953983, 17388.13059347053, 17435.04107274112, 17475.650486990442], "unit": "ms", "name": "jquery.html", "value": 10499.73311009243}, {"lowerIsBetter": false, "replicates": [1413.095618803965, 1535.8387369326229, 1543.1898253416955, 1890.6029733755915, 1902.1915685833521, 7668.424868134891, 7943.126256111837, 7972.043354797425, 7972.322352600021, 7981.042274927009, 7750.108737495176, 8179.672813087484, 8320.33437325014, 8325.000999880007, 8329.83340333193, 2328.289871589169, 2402.3994001499627, 2404.146527982567, 2405.3265085775924, 2420.7579242075826, 2370.928872133839, 2407.963880541793, 2437.2688193541867, 2437.8659173745436, 2445.364205306615, 2305.9077636894503, 2369.9763002370014, 2397.424618091663, 2408.9759102409016, 2410.361254267612, 2348.1194552042984, 2366.597678394677, 2398.568257713611, 2402.615581506968, 2403.2069417092407, 2370.8696021718797, 2391.1272385579136, 2413.7827595516487, 2424.5514579802793, 2432.6351047342864, 8368.456050356708, 8459.619317130744, 8465.492070475791, 8470.364722645827, 8472.661093556251, 4711.411073615798, 5101.15830887903, 5198.896022079537, 5206.114960456732, 5247.737613119329, 2964.889726034213, 3204.3591281743743, 3225.741940644766, 3355.7986520808586, 3466.185446420089, 922.2806211155242, 1033.1270076785104, 1057.5135437698668, 1062.1184416933927, 1063.2132222155626, 11078.501467433985, 11107.333559986426, 11122.49948752308, 11140.053095486894, 11174.27367221128, 4673.579377856009, 4742.383490146259, 4777.474477807438, 4786.760661966888, 4802.255650374198, 9598.136167744797, 9609.615615375447, 9636.662716804878, 9643.324967252365, 9650.179734722487, 5224.425313215619, 5255.789768409298, 5266.4470230626, 5275.366955965232, 5296.232046353334, 4822.95177048232, 4826.0589185108565, 4828.7102773833685, 4831.637627177905, 4835.274708793709, 3663.87176448823, 3674.614165512636, 3679.0434487033563, 3685.4103343465454, 3710.6474884885893, 1140.156284349592, 1150.9079273658087, 1152.3201311226417, 1169.0238650726737, 1170.789257933563, 1110.5724296146043, 1115.4088333183427, 1162.1167912386647, 1312.4946895445323, 1424.8788852947616, 7861.056673199253, 7866.292033716879, 7947.602619868983, 7958.204179581995, 7968.521888686697, 1141.9257748246337, 1159.4434671357797, 1200.363807182195, 1205.2467207995003, 1205.7588482303574, 5912.17229587858, 6210.006398976142, 6251.343608921089, 6268.49852011838, 6288.088227207029, 8867.467951922905, 9741.220702343795, 10095.394276343442, 10095.9495202525, 10121.443320617289, 9893.802123957481, 9983.700488985342, 9994.050565196294, 10004.799904001879, 10065.647702330383, 7818.648160832776, 7866.252705992922, 7911.28798408146, 7990.161033091442, 7999.360131173095, 6210.378962103753, 7697.345725613385, 7735.806604834924, 7772.028496437945, 7836.373090152888, 9024.0, 9077.001529831581, 9128.178463938277, 9164.221041211305, 9205.493697846683, 9010.909890901006, 9192.402493837879, 9331.346805723535, 9504.619815207314, 9518.23854091685, 6133.3866613338305, 7226.927730722836, 7330.926690733238, 7339.486235963432, 7361.2638736125955, 7830.256125668053, 7924.247196516321, 7930.484518506279, 7940.6029698515995, 7941.761747147595, 7318.524295920748, 7416.517926334771, 7442.9255707442235, 7502.624868756649, 7595.506292090997, 7341.669624866787, 7351.522151060164, 7441.8139546511775, 7467.215942325977, 7474.364679002346, 7318.487705860539, 7462.067241594801, 7480.027596412431, 7491.0, 7498.962505187439, 6802.8639427212165, 6836.726530938906, 6838.316168383122, 6843.828904277433, 6850.349216824394, 6747.190337159573, 6816.556923799937, 6855.348741869514, 6856.725730970905, 6862.176538815374], "unit": "ms", "name": "mootools.html", "value": 4761.840807015585}, {"lowerIsBetter": false, "replicates": [300.3467458278244, 321.25949685973836, 324.6266793187834, 330.82466292864785, 335.2222843004228, 6894.793666026873, 7073.646317684108, 7075.5942979387, 7079.929200707991, 7087.85824283514, 6970.442364610832, 6981.6509174541325, 6981.685824137913, 6984.05715228444, 7008.61452620107, 4297.591728785776, 4924.236743304794, 4979.377577802775, 5028.2709007193935, 5050.671706339085, 4891.241857512091, 4962.1812400953795, 5129.410117836459, 5132.153194722866, 5132.717700526469, 4113.568075352075, 4159.334506478964, 5087.135187018197, 5099.260607211952, 5116.8976620467565, 4869.2939523768855, 5012.598992080625, 5082.923756143679, 5091.236314552828, 5111.4121875984365, 4221.894452638678, 4234.343676730112, 4316.784160791948, 4323.632491238249, 4328.2209202343565, 5281.313429254173, 6666.200055993312, 6672.0325552794575, 6694.56485328457, 6695.230048544431, 4866.46468888422, 6043.758249670008, 6044.24446944132, 6048.606840555394, 6064.514838812928, 7139.321764432422, 7420.035395398563, 7439.0, 7443.106827180719, 7467.738629147953, 4868.488808675073, 4871.147549178915, 4875.073735990186, 4877.0, 4878.268259761065, 6893.448524118108, 7131.965864949553, 7907.683692652287, 7915.406344524126, 7929.96035019827, 4066.898327541776, 4466.793965629262, 4699.483056863743, 4810.350602668665, 4816.975915120402, 4431.224535706238, 4865.416150061945, 4877.219644856877, 4885.8045678173185, 4890.364252647204, 5288.550473209743, 5496.835094947158, 5907.320658124285, 5913.881722365529, 5945.286565612154, 7200.811866042044, 7464.738734144279, 7471.178170401252, 7485.251474852471, 7529.623518824146, 1509.9320530576151, 1639.3114891745495, 1689.8056723476711, 1710.598009467774, 1712.571857035741, 1072.131573425528, 1076.8761592416815, 1080.114306268852, 1082.767205050902, 1093.9015488606065, 6752.729890804411, 7059.682314295869, 7064.492105302544, 7070.186928503185, 7090.574565526085, 6659.600423974577, 7776.416768742254, 7791.4156438267355, 7798.220177982156, 7810.297073263434, 6819.795406137824, 6972.0, 7002.264762199896, 7027.718891244395, 7064.293570642894, 3970.4838371011583, 4070.3080476319096, 4072.8778136655947, 4079.673626109904, 4110.856120035784, 8083.151269116775, 8106.716264930699, 8146.714864979697, 8150.0, 8162.469439486415, 7863.410244231705, 8063.959680201561, 8064.153263907323, 8096.149904260085, 8158.918410815934, 7373.594452305175, 7836.37309015266, 8190.959045204855, 8205.097439281673, 8213.753587392388, 5751.511121554715, 7498.0, 7853.725119620786, 7864.056313242448, 7864.370850332074, 7442.06974128234, 7686.884696729665, 7689.192634773268, 7708.344790692629, 7731.613419329124, 8163.0, 8164.7958801030445, 8173.264406203232, 8177.059638141452, 8200.26197642215, 4694.6244300456565, 4785.712857228577, 4841.05599408112, 4848.466668666514, 4851.830185943475, 6315.621062736251, 7744.92255077442, 7787.29914307715, 7787.610619469117, 7808.063032436144, 7540.698372065056, 7541.773746787605, 7545.811354716176, 7558.055243094614, 7560.58416787082, 6871.0, 6918.688659010458, 7314.378277846443, 7531.548107113591, 7551.848963020599, 7356.963215184104, 7365.742199023009, 7368.115826100902, 7377.889331659922, 7388.445866559922, 6325.304216536269, 7013.193482749345, 7349.4487913407775, 7518.924810751822, 7541.116325092472, 6978.337057979484, 7383.778486645409, 7386.298301661333, 7389.002484664501, 7401.185869554452], "unit": "ms", "name": "prototype.html", "value": 5363.553146063454}, {"lowerIsBetter": false, "replicates": [773.9226077392261, 794.9903622399553, 795.6777505110432, 824.1922915542764, 840.8150206954475, 14804.333804978774, 15141.470048548303, 15144.77282840757, 15159.772603410931, 15170.544883653494, 14030.228337441436, 14172.71654566908, 14176.0, 14191.78712319316, 14201.78697319541, 756.5611945071872, 761.6762875777772, 938.699616122841, 962.4946902875976, 963.585658166988, 754.4944886925746, 767.57399643198, 769.2000319667567, 772.0966469231013, 773.6015951784835, 1009.7273736091252, 1024.9077583017527, 1025.4770067265674, 1025.6871654145482, 1027.2141811514198, 966.6326795817614, 985.6845809341014, 1008.4403156248279, 1010.8635334229895, 1011.3931641015332, 592.5141384065068, 593.2702775586054, 600.909863520471, 743.7434085240637, 750.9812254693621, 14553.272336383245, 14639.63400914975, 14667.706645867023, 14704.779428308584, 14771.33528991198, 12091.153619246656, 12271.877281227253, 12329.568465103768, 12704.983601311966, 12773.552925647651, 10265.178785697126, 10273.589056437733, 10298.433586152758, 10437.895621043768, 11056.723581910435, 3490.7207423406066, 3527.400341941876, 3534.6288639692975, 3535.840887160084, 3547.6984456321243, 75954.48091038148, 77282.0, 77384.0, 79566.40867182682, 84101.15898840994, 9343.672971445967, 9353.766155846159, 9355.812883742423, 9396.90603093974, 9733.707988760349, 21478.57042859134, 21625.24311649116, 21751.891240543697, 21768.23811166633, 21769.891150544147, 7454.776356709307, 7497.1753107158165, 7524.209957954446, 7537.623118844036, 7729.420293478011, 4132.834686612562, 4140.44104045956, 4158.8336466540995, 4160.4591403118, 4190.832366705297, 3626.437902125175, 3664.926701465956, 3668.5781135169264, 3672.6143754905884, 3673.430618254175, 631.835722712089, 641.4355367276767, 644.0371644391664, 661.9900701489481, 663.4990582110476, 507.7207535855339, 515.1885779896678, 516.8036146264395, 518.4426741253168, 547.2366049361199, 9110.635574576943, 9709.27180461454, 9745.463999480096, 9768.462734549526, 9787.119159275699, 523.8245187862033, 546.5764032874474, 555.2060553408584, 559.7900787204799, 588.685053496386, 4158.875233742992, 4460.955390446119, 4522.66080043998, 4549.590536851633, 4582.908341833145, 99165.50417248011, 100663.0, 103846.0, 105455.0, 105983.47008265063, 88775.11224887798, 88912.0, 89355.0, 89517.0, 90031.0, 78312.0, 78330.2166978323, 78801.60599196967, 78909.21090789133, 79452.60273698595, 9071.410358326688, 9089.0, 9098.681546145854, 9145.496997665192, 9199.724008279762, 55161.44838551563, 55332.0, 55510.16734749063, 55779.44220557905, 56441.0, 65608.67195663991, 74353.07763068467, 77824.0, 78758.0, 78785.0, 11636.592719254786, 11638.06895448379, 11657.358845263592, 11741.706457338634, 12147.514099436277, 12194.085443591588, 12523.060770442435, 12608.306543139848, 12625.810612840998, 13001.024923130992, 11329.830052549054, 11485.310881347146, 11710.4730287139, 11962.880371196177, 12536.937315313366, 11424.028957538701, 11446.484908179318, 11793.764124717629, 11817.881821181678, 12583.433745481658, 11165.609203677832, 11521.481533331187, 11616.709582260512, 11647.534098635959, 12331.50673973031, 8546.615402307036, 9756.219502439646, 9795.118439340493, 10029.14752246038, 10361.274710770174, 9093.363464557417, 9196.402233854778, 9484.810303793747, 10125.64560240388, 10198.643047493302], "unit": "ms", "name": "yui.html", "value": 7118.996370219321}], "name": "dromaeo_css", "value": 7812.535079622853}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 104.0, 109.0, 110.0, 110.0, 108.0, 109.0, 101.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [146.0, 118.0, 140.0, 153.0, 117.0, 140.0, 138.0, 118.0, 156.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 134.2}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 182.0, 185.0, 184.0, 184.0, 183.0, 182.0, 184.0, 185.0], "unit": "ms", "name": "audio-dft", "value": 183.7}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 73.0, 71.0, 55.0, 56.0, 57.0, 70.0, 71.0, 56.0], "unit": "ms", "name": "audio-fft", "value": 64.1}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 118.0, 82.0, 106.0, 111.0, 135.0, 74.0, 76.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 98.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 86.0, 85.0, 85.0, 87.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 94.0, 97.0, 88.0, 131.0, 118.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 99.5}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 89.0, 85.0, 87.0, 88.0, 89.0, 87.0, 96.0, 133.0], "unit": "ms", "name": "imaging-desaturate", "value": 93.6}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 53.0, 54.0, 54.0, 55.0, 53.0, 63.0, 51.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 66.0, 66.0, 66.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 82.0, 83.0, 82.0, 84.0, 81.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 126.0, 119.0, 128.0, 129.0, 147.0, 125.0, 124.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [133.0, 133.0, 130.0, 132.0, 130.0, 121.0, 117.0, 138.0, 170.0, 153.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 68.0, 91.0, 63.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1400.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.5796930342385], "unit": "score", "name": "Richards", "value": 239.206352}, {"lowerIsBetter": false, "replicates": [159.92323684631376], "unit": "score", "name": "DeltaBlue", "value": 413.4358539999999}, {"lowerIsBetter": false, "replicates": [310.2699348433137], "unit": "score", "name": "Encrypt", "value": 857.9013629999996}, {"lowerIsBetter": false, "replicates": [4686.915887850468], "unit": "score", "name": "Decrypt", "value": 56.79235692921238}, {"lowerIsBetter": false, "replicates": [1700.6802721088436], "unit": "score", "name": "RayTrace", "value": 435.113532}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [13171.052631578947], "unit": "score", "name": "Boyer", "value": 50.60058741258738}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [677.5067750677507], "unit": "score", "name": "Splay", "value": 120.28071599999996}, {"lowerIsBetter": false, "replicates": [4502.242152466368], "unit": "score", "name": "NavierStokes", "value": 329.61354581673305}], "name": "v8_7", "value": 20405.710801200716}]} 16:15:33 INFO - RETURN: dromaeo_css: 7812.53 16:15:33 INFO - RETURN: kraken: 1400.40 16:15:33 INFO - RETURN: v8_7: 20405.71 16:15:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20405.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1400.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7812.53"}}} 16:15:33 INFO - Return code: 0 16:15:33 INFO - # TBPL SUCCESS # 16:15:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:15:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:15:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:15:33 INFO - 2015-11-19 16:15:33.177 screenresolution[1668:10386] starting screenresolution argv=screenresolution get 16:15:33 INFO - 2015-11-19 16:15:33.179 screenresolution[1668:10386] Display 0: 1600x1200x32@60 16:15:33 INFO - 2015-11-19 16:15:33.185 screenresolution[1669:10389] starting screenresolution argv=screenresolution list 16:15:33 INFO - Available Modes on Display 0 16:15:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:15:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:15:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:15:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:15:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:15:33 INFO - Intel Iris: 16:15:33 INFO - Chipset Model: Intel Iris 16:15:33 INFO - Type: GPU 16:15:33 INFO - Bus: Built-In 16:15:33 INFO - VRAM (Dynamic, Max): 1536 MB 16:15:33 INFO - Vendor: Intel (0x8086) 16:15:33 INFO - Device ID: 0x0a2e 16:15:33 INFO - Revision ID: 0x0009 16:15:33 INFO - Displays: 16:15:33 INFO - Display: 16:15:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:15:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:15:33 INFO - Display Serial Number: 1600x1200 60 16:15:33 INFO - Main Display: Yes 16:15:33 INFO - Mirror: Off 16:15:33 INFO - Online: Yes 16:15:33 INFO - Rotation: Supported 16:15:33 INFO - Return code: 0 16:15:33 INFO - Running post-action listener: _resource_record_post_action 16:15:33 INFO - Running post-run listener: _resource_record_post_run 16:15:34 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 33525248; Write bytes: 694180864; Read time: 358; Write time: 2435 16:15:34 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 339347968; Write bytes: 339400192; Read time: 25969; Write time: 649 16:15:34 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 31555072; Write bytes: 343488000; Read time: 327; Write time: 1751 16:15:34 INFO - Running post-run listener: _upload_blobber_files 16:15:34 INFO - Blob upload gear active. 16:15:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:15:34 INFO - Copying logs to upload dir... 16:15:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.092945 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 16:15:34.656181) ========= ========= Started set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-19 16:15:34.661239) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009536 build_url: 'https://queue.taskcluster.net/v1/task/1NwMYSSQS-e6xlxPDYtBvQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 4.21 ========= ========= Finished set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-19 16:15:38.880082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-11-19 16:15:38.880397) ========= 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.URRUVaw6rT/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.eiTH48E2Gu/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005304 ========= master_lag: 10.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2015-11-19 16:15:48.924653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:15:48.924990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:15:49.213731) ========= ========= Total master_lag: 14.52 =========