builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0012 starttime: 1447974894.57 results: success (0) buildid: 20151119131711 builduid: 6d6c9d982c714986b3e8316b1c98c402 revision: a76322320837ac6d0c9510c280706359a47ea309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.569821) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.570258) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.570574) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005480 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.590621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.590979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.607119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.607490) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.656114) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.659469) ========= 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:14:54.659849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:54.660152) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:14:54-- 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% 19.6M=0.001s 2015-11-19 15:14:54 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106855 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:55.001617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:55.001961) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.019734 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:55.034248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 15:14:55.034616) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a76322320837ac6d0c9510c280706359a47ea309 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a76322320837ac6d0c9510c280706359a47ea309 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:14:55,111 truncating revision to first 12 chars 2015-11-19 15:14:55,111 Setting DEBUG logging. 2015-11-19 15:14:55,111 attempt 1/10 2015-11-19 15:14:55,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a76322320837?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 15:14:56,316 unpacking tar archive at: mozilla-central-a76322320837/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 15:14:56.502396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:56.502961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:56.515407) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:14:56.515671) ========= 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:14:56.516054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2015-11-19 15:14:56.516360) ========= /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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:14:56 INFO - MultiFileLogger online at 20151119 15:14:56 in /builds/slave/test 15:14:56 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:14:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:56 INFO - {'append_to_log': False, 15:14:56 INFO - 'base_work_dir': '/builds/slave/test', 15:14:56 INFO - 'blob_upload_branch': 'Firefox', 15:14:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:56 INFO - 'branch': 'Firefox', 15:14:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:56 INFO - 'config_files': ('talos/mac_config.py',), 15:14:56 INFO - 'default_actions': ('clobber', 15:14:56 INFO - 'read-buildbot-config', 15:14:56 INFO - 'download-and-extract', 15:14:56 INFO - 'populate-webroot', 15:14:56 INFO - 'create-virtualenv', 15:14:56 INFO - 'install', 15:14:56 INFO - 'run-tests'), 15:14:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:56 INFO - 'download_minidump_stackwalk': True, 15:14:56 INFO - 'download_symbols': 'ondemand', 15:14:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:56 INFO - 'installer_path': 'installer.exe', 15:14:56 INFO - 'log_level': 'info', 15:14:56 INFO - 'log_name': 'talos', 15:14:56 INFO - 'log_to_console': True, 15:14:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:14:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:14:56 INFO - 'opt_config_files': (), 15:14:56 INFO - 'pip_index': False, 15:14:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:56 INFO - 'cmd': ('bash', 15:14:56 INFO - '-c', 15:14:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:14:56 INFO - 'enabled': True, 15:14:56 INFO - 'halt_on_failure': False, 15:14:56 INFO - 'name': 'check_screen_resolution'},), 15:14:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:56 INFO - 'cmd': ('bash', 15:14:56 INFO - '-c', 15:14:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:14:56 INFO - 'enabled': True, 15:14:56 INFO - 'halt_on_failure': False, 15:14:56 INFO - 'name': 'check_screen_resolution'},), 15:14:56 INFO - 'run_cmd_checks_enabled': True, 15:14:56 INFO - 'sps_profile': False, 15:14:56 INFO - 'sps_profile_interval': 0, 15:14:56 INFO - 'suite': 'dromaeojs', 15:14:56 INFO - 'system_bits': '64', 15:14:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:56 INFO - 'title': 't-yosemite-r7-0012', 15:14:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:56 INFO - 'use_talos_json': True, 15:14:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:56 INFO - 'work_dir': 'build'} 15:14:56 INFO - ##### 15:14:56 INFO - ##### Running clobber step. 15:14:56 INFO - ##### 15:14:56 INFO - Running pre-action listener: _resource_record_pre_action 15:14:56 INFO - Running main action method: clobber 15:14:56 INFO - rmtree: /builds/slave/test/build 15:14:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:57 INFO - Running post-action listener: _resource_record_post_action 15:14:57 INFO - ##### 15:14:57 INFO - ##### Running read-buildbot-config step. 15:14:57 INFO - ##### 15:14:57 INFO - Running pre-action listener: _resource_record_pre_action 15:14:57 INFO - Running main action method: read_buildbot_config 15:14:57 INFO - Using buildbot properties: 15:14:57 INFO - { 15:14:57 INFO - "properties": { 15:14:57 INFO - "buildnumber": 0, 15:14:57 INFO - "product": "firefox", 15:14:57 INFO - "script_repo_revision": "production", 15:14:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:14:57 INFO - "repository": "", 15:14:57 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:14:57 INFO - "buildid": "20151119131711", 15:14:57 INFO - "slavename": "t-yosemite-r7-0012", 15:14:57 INFO - "pgo_build": "False", 15:14:57 INFO - "basedir": "/builds/slave/test", 15:14:57 INFO - "project": "", 15:14:57 INFO - "platform": "yosemite_r7", 15:14:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:14:57 INFO - "slavebuilddir": "test", 15:14:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:14:57 INFO - "branch": "mozilla-central", 15:14:57 INFO - "repo_path": "mozilla-central", 15:14:57 INFO - "stage_platform": "macosx64", 15:14:57 INFO - "builduid": "6d6c9d982c714986b3e8316b1c98c402", 15:14:57 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:14:57 INFO - }, 15:14:57 INFO - "sourcestamp": { 15:14:57 INFO - "repository": "", 15:14:57 INFO - "hasPatch": false, 15:14:57 INFO - "project": "", 15:14:57 INFO - "branch": "mozilla-central-macosx64-talos", 15:14:57 INFO - "changes": [ 15:14:57 INFO - { 15:14:57 INFO - "category": null, 15:14:57 INFO - "files": [ 15:14:57 INFO - { 15:14:57 INFO - "url": null, 15:14:57 INFO - "name": "https://queue.taskcluster.net/v1/task/DZXiqgWiTkyd8C4BqQjGbw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:14:57 INFO - } 15:14:57 INFO - ], 15:14:57 INFO - "repository": "", 15:14:57 INFO - "rev": "5dcdd3c728fac543a832c9081d7221ee912ba762", 15:14:57 INFO - "who": "kwierso@gmail.com", 15:14:57 INFO - "when": 1447974168, 15:14:57 INFO - "number": 6685600, 15:14:57 INFO - "comments": "Bug 1219883 - Fix Ion typed array stub to handle constant string index. r=efaust", 15:14:57 INFO - "project": "", 15:14:57 INFO - "at": "Thu 19 Nov 2015 15:02:48", 15:14:57 INFO - "branch": "mozilla-central-macosx64-talos", 15:14:57 INFO - "revlink": "", 15:14:57 INFO - "properties": [ 15:14:57 INFO - [ 15:14:57 INFO - "buildid", 15:14:57 INFO - "20151119131012", 15:14:57 INFO - "Change" 15:14:57 INFO - ], 15:14:57 INFO - [ 15:14:57 INFO - "builduid", 15:14:57 INFO - "a82f3d5dd6af402d9963330d8dd6d2e4", 15:14:57 INFO - "Change" 15:14:57 INFO - ], 15:14:57 INFO - [ 15:14:57 INFO - "pgo_build", 15:14:57 INFO - "False", 15:14:57 INFO - "Change" 15:14:57 INFO - ] 15:14:57 INFO - ], 15:14:57 INFO - "revision": "5dcdd3c728fac543a832c9081d7221ee912ba762" 15:14:57 INFO - }, 15:14:57 INFO - { 15:14:57 INFO - "category": null, 15:14:57 INFO - "files": [ 15:14:57 INFO - { 15:14:57 INFO - "url": null, 15:14:57 INFO - "name": "https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:14:57 INFO - } 15:14:57 INFO - ], 15:14:57 INFO - "repository": "", 15:14:57 INFO - "rev": "a76322320837ac6d0c9510c280706359a47ea309", 15:14:57 INFO - "who": "kwierso@gmail.com", 15:14:57 INFO - "when": 1447974858, 15:14:57 INFO - "number": 6685686, 15:14:57 INFO - "comments": "Touch CLOBBER to clear up bug 1168113's bustage a=merge", 15:14:57 INFO - "project": "", 15:14:57 INFO - "at": "Thu 19 Nov 2015 15:14:18", 15:14:57 INFO - "branch": "mozilla-central-macosx64-talos", 15:14:57 INFO - "revlink": "", 15:14:57 INFO - "properties": [ 15:14:57 INFO - [ 15:14:57 INFO - "buildid", 15:14:57 INFO - "20151119131711", 15:14:57 INFO - "Change" 15:14:57 INFO - ], 15:14:57 INFO - [ 15:14:57 INFO - "builduid", 15:14:57 INFO - "6d6c9d982c714986b3e8316b1c98c402", 15:14:57 INFO - "Change" 15:14:57 INFO - ], 15:14:57 INFO - [ 15:14:57 INFO - "pgo_build", 15:14:57 INFO - "False", 15:14:57 INFO - "Change" 15:14:57 INFO - ] 15:14:57 INFO - ], 15:14:57 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:14:57 INFO - } 15:14:57 INFO - ], 15:14:57 INFO - "revision": "a76322320837ac6d0c9510c280706359a47ea309" 15:14:57 INFO - } 15:14:57 INFO - } 15:14:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:14:57 INFO - Running post-action listener: _resource_record_post_action 15:14:57 INFO - ##### 15:14:57 INFO - ##### Running download-and-extract step. 15:14:57 INFO - ##### 15:14:57 INFO - Running pre-action listener: _resource_record_pre_action 15:14:57 INFO - Running main action method: download_and_extract 15:14:57 INFO - mkdir: /builds/slave/test/build/tests 15:14:57 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:14:57 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json 15:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json 15:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:14:58 INFO - Downloaded 1149 bytes. 15:14:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:14:58 INFO - Using the following test package requirements: 15:14:58 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:14:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:14:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'jsshell-mac.zip'], 15:14:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:14:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:14:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:14:58 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:14:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:14:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:14:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:14:58 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:14:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:58 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:14:59 INFO - Downloaded 17522538 bytes. 15:14:59 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:14:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:14:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:15:02 INFO - Return code: 0 15:15:02 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:15:02 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:15:02 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:15:04 INFO - Downloaded 17522538 bytes. 15:15:04 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:15:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:15:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:15:07 INFO - Return code: 0 15:15:07 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:15:07 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:15:08 INFO - Downloaded 11130997 bytes. 15:15:08 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:15:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:15:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:15:08 INFO - Return code: 0 15:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:08 INFO - https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 15:15:22 INFO - Downloaded 109423896 bytes. 15:15:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:15:22 INFO - mkdir: /builds/slave/test/properties 15:15:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:22 INFO - Contents: 15:15:22 INFO - build_url:https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:15:22 INFO - Running post-action listener: _resource_record_post_action 15:15:22 INFO - Running post-action listener: set_extra_try_arguments 15:15:22 INFO - ##### 15:15:22 INFO - ##### Running populate-webroot step. 15:15:22 INFO - ##### 15:15:22 INFO - Running pre-action listener: _resource_record_pre_action 15:15:22 INFO - Running main action method: populate_webroot 15:15:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:15:22 INFO - '../fennec_ids.txt'], 15:15:22 INFO - 'tests': ['tcheck2']}, 15:15:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:22 INFO - '--tppagecycles', 15:15:22 INFO - '7'], 15:15:22 INFO - 'tests': ['tsvgm']}}, 15:15:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:15:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:15:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:15:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'tests': ['damp', 'tps']}, 15:15:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['damp', 'tps']}, 15:15:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:15:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:22 INFO - 'other': {'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'other_l64': {'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'other_nol64': {'tests': ['a11yr', 15:15:22 INFO - 'ts_paint', 15:15:22 INFO - 'tpaint', 15:15:22 INFO - 'sessionrestore', 15:15:22 INFO - 'sessionrestore_no_auto_restore']}, 15:15:22 INFO - 'svgr': {'tests': ['tsvgx', 15:15:22 INFO - 'tsvgr_opacity', 15:15:22 INFO - 'tart', 15:15:22 INFO - 'tscrollx', 15:15:22 INFO - 'cart']}, 15:15:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['tsvgx', 15:15:22 INFO - 'tsvgr_opacity', 15:15:22 INFO - 'tart', 15:15:22 INFO - 'tscrollx', 15:15:22 INFO - 'cart']}, 15:15:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'tests': ['tp5o']}, 15:15:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'talos_options': ['--e10s'], 15:15:22 INFO - 'tests': ['tp5o']}, 15:15:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'talos_options': ['--xperf_path', 15:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:22 INFO - 'tests': ['tp5n']}, 15:15:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:22 INFO - 'talos_options': ['--e10s', 15:15:22 INFO - '--xperf_path', 15:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:22 INFO - 'tests': ['tp5n']}}, 15:15:22 INFO - 'talos.zip': {'path': '', 15:15:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:22 INFO - Running post-action listener: _resource_record_post_action 15:15:22 INFO - ##### 15:15:22 INFO - ##### Running create-virtualenv step. 15:15:22 INFO - ##### 15:15:22 INFO - Running pre-action listener: _resource_record_pre_action 15:15:22 INFO - Running main action method: create_virtualenv 15:15:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:22 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:15:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:22 INFO - Using real prefix '/tools/python27' 15:15:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:25 INFO - Installing pip.................done. 15:15:25 INFO - Return code: 0 15:15:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:25 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:25 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:15:25 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:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:25 INFO - 'HOME': '/Users/cltbld', 15:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:25 INFO - 'LOGNAME': 'cltbld', 15:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:25 INFO - 'MOZ_NO_REMOTE': '1', 15:15:25 INFO - 'NO_EM_RESTART': '1', 15:15:25 INFO - 'PAGER': '/bin/cat', 15:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:25 INFO - 'PWD': '/builds/slave/test', 15:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:25 INFO - 'SHELL': '/bin/bash', 15:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:25 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:25 INFO - 'USER': 'cltbld', 15:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:25 INFO - 'XPC_FLAGS': '0x0', 15:15:25 INFO - 'XPC_SERVICE_NAME': '0', 15:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:26 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:15:26 INFO - Cleaning up... 15:15:26 INFO - Return code: 0 15:15:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:15: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:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:26 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:26 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:15:26 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:15:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:26 INFO - 'HOME': '/Users/cltbld', 15:15:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:26 INFO - 'LOGNAME': 'cltbld', 15:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:26 INFO - 'MOZ_NO_REMOTE': '1', 15:15:26 INFO - 'NO_EM_RESTART': '1', 15:15:26 INFO - 'PAGER': '/bin/cat', 15:15:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:26 INFO - 'PWD': '/builds/slave/test', 15:15:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:26 INFO - 'SHELL': '/bin/bash', 15:15:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:26 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:26 INFO - 'USER': 'cltbld', 15:15:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:26 INFO - 'XPC_FLAGS': '0x0', 15:15:26 INFO - 'XPC_SERVICE_NAME': '0', 15:15:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:26 INFO - Downloading/unpacking psutil>=0.7.1 15:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:15:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:29 INFO - Installing collected packages: psutil 15:15:29 INFO - Running setup.py install for psutil 15:15:29 INFO - building 'psutil._psutil_osx' extension 15:15:29 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:15:29 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:15:29 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:15:29 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:15:29 INFO - building 'psutil._psutil_posix' extension 15:15:29 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:15:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:15:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:15:29 INFO - ^ 15:15:29 INFO - 1 warning generated. 15:15:29 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:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:30 INFO - Successfully installed psutil 15:15:30 INFO - Cleaning up... 15:15:30 INFO - Return code: 0 15:15:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:30 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:30 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:15:30 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:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:30 INFO - 'HOME': '/Users/cltbld', 15:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:30 INFO - 'LOGNAME': 'cltbld', 15:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:30 INFO - 'MOZ_NO_REMOTE': '1', 15:15:30 INFO - 'NO_EM_RESTART': '1', 15:15:30 INFO - 'PAGER': '/bin/cat', 15:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:30 INFO - 'PWD': '/builds/slave/test', 15:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:30 INFO - 'SHELL': '/bin/bash', 15:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:30 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:30 INFO - 'USER': 'cltbld', 15:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:30 INFO - 'XPC_FLAGS': '0x0', 15:15:30 INFO - 'XPC_SERVICE_NAME': '0', 15:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:15:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:32 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:15:32 INFO - Installing collected packages: mozsystemmonitor 15:15:32 INFO - Running setup.py install for mozsystemmonitor 15:15:32 INFO - Successfully installed mozsystemmonitor 15:15:32 INFO - Cleaning up... 15:15:32 INFO - Return code: 0 15:15:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15: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:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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', '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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:15: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 blobuploader==1.2.4 15:15:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:32 INFO - 'HOME': '/Users/cltbld', 15:15:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:32 INFO - 'LOGNAME': 'cltbld', 15:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:32 INFO - 'MOZ_NO_REMOTE': '1', 15:15:32 INFO - 'NO_EM_RESTART': '1', 15:15:32 INFO - 'PAGER': '/bin/cat', 15:15:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:32 INFO - 'PWD': '/builds/slave/test', 15:15:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:32 INFO - 'SHELL': '/bin/bash', 15:15:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:32 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:32 INFO - 'USER': 'cltbld', 15:15:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:32 INFO - 'XPC_FLAGS': '0x0', 15:15:32 INFO - 'XPC_SERVICE_NAME': '0', 15:15:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:33 INFO - Downloading/unpacking blobuploader==1.2.4 15:15: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:15: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:15: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:15: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:15: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:15: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:15:35 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:36 INFO - Downloading docopt-0.6.1.tar.gz 15:15:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:36 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:36 INFO - Running setup.py install for blobuploader 15:15:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:36 INFO - Running setup.py install for requests 15:15:37 INFO - Running setup.py install for docopt 15:15:37 INFO - Successfully installed blobuploader requests docopt 15:15:37 INFO - Cleaning up... 15:15:37 INFO - Return code: 0 15:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:37 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:37 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:15:37 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:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:37 INFO - 'HOME': '/Users/cltbld', 15:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:37 INFO - 'LOGNAME': 'cltbld', 15:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:37 INFO - 'MOZ_NO_REMOTE': '1', 15:15:37 INFO - 'NO_EM_RESTART': '1', 15:15:37 INFO - 'PAGER': '/bin/cat', 15:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:37 INFO - 'PWD': '/builds/slave/test', 15:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:37 INFO - 'SHELL': '/bin/bash', 15:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:37 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:37 INFO - 'USER': 'cltbld', 15:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:37 INFO - 'XPC_FLAGS': '0x0', 15:15:37 INFO - 'XPC_SERVICE_NAME': '0', 15:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:37 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-WPxCZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:37 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5WPbK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:37 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-jQUEzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:37 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-hgwnAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-2ZRWdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wbui43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-_2pY8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-WB7tuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wyqInu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-p2CRnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5qddHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-M_gBRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-eUm2fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:38 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-V9lUA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-LURKh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-3Ku7R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-uQjU4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:39 INFO - Running setup.py install for manifestparser 15:15:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:39 INFO - Running setup.py install for mozcrash 15:15:39 INFO - Running setup.py install for mozdebug 15:15:39 INFO - Running setup.py install for mozdevice 15:15:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:39 INFO - Running setup.py install for mozfile 15:15:40 INFO - Running setup.py install for mozhttpd 15:15:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Running setup.py install for mozinfo 15:15:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Running setup.py install for mozInstall 15:15:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Running setup.py install for mozleak 15:15:40 INFO - Running setup.py install for mozlog 15:15:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Running setup.py install for moznetwork 15:15:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:40 INFO - Running setup.py install for mozprocess 15:15:41 INFO - Running setup.py install for mozprofile 15:15:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:41 INFO - Running setup.py install for mozrunner 15:15:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:41 INFO - Running setup.py install for mozscreenshot 15:15:41 INFO - Running setup.py install for moztest 15:15:41 INFO - Running setup.py install for mozversion 15:15:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:41 INFO - Cleaning up... 15:15:41 INFO - Return code: 0 15:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:41 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:41 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:15:41 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:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:41 INFO - 'HOME': '/Users/cltbld', 15:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:41 INFO - 'LOGNAME': 'cltbld', 15:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:41 INFO - 'MOZ_NO_REMOTE': '1', 15:15:41 INFO - 'NO_EM_RESTART': '1', 15:15:41 INFO - 'PAGER': '/bin/cat', 15:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:41 INFO - 'PWD': '/builds/slave/test', 15:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:41 INFO - 'SHELL': '/bin/bash', 15:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:41 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:41 INFO - 'USER': 'cltbld', 15:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:41 INFO - 'XPC_FLAGS': '0x0', 15:15:41 INFO - 'XPC_SERVICE_NAME': '0', 15:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ZftI3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-57MC0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-cMu5IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-nJ6LkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-myCiJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-PUVba6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-6ZLidK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:42 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:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:42 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-_r1FPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-rLj7lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-M6jIMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Z1ksah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-QGQP2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-vlTGqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-T4RXAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-zCDnxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-XwkaFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:43 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:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:43 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UuKE1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 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:15:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:46 INFO - Downloading blessings-1.5.1.tar.gz 15:15:46 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:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:46 INFO - Installing collected packages: blessings 15:15:46 INFO - Running setup.py install for blessings 15:15:46 INFO - Successfully installed blessings 15:15:46 INFO - Cleaning up... 15:15:46 INFO - Return code: 0 15:15:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:46 INFO - Reading from file tmpfile_stdout 15:15:46 INFO - Current package versions: 15:15:46 INFO - blessings == 1.5.1 15:15:46 INFO - blobuploader == 1.2.4 15:15:46 INFO - docopt == 0.6.1 15:15:46 INFO - manifestparser == 1.1 15:15:46 INFO - mozInstall == 1.12 15:15:46 INFO - mozcrash == 0.16 15:15:46 INFO - mozdebug == 0.1 15:15:46 INFO - mozdevice == 0.47 15:15:46 INFO - mozfile == 1.2 15:15:46 INFO - mozhttpd == 0.7 15:15:46 INFO - mozinfo == 0.9 15:15:46 INFO - mozleak == 0.1 15:15:46 INFO - mozlog == 3.0 15:15:46 INFO - moznetwork == 0.27 15:15:46 INFO - mozprocess == 0.22 15:15:46 INFO - mozprofile == 0.27 15:15:46 INFO - mozrunner == 6.11 15:15:46 INFO - mozscreenshot == 0.1 15:15:46 INFO - mozsystemmonitor == 0.0 15:15:46 INFO - moztest == 0.7 15:15:46 INFO - mozversion == 1.4 15:15:46 INFO - psutil == 3.1.1 15:15:46 INFO - requests == 1.2.3 15:15:46 INFO - wsgiref == 0.1.2 15:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 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 0x10fa74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa51228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feda9cad000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, '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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:15:46 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:15:46 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:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:46 INFO - 'HOME': '/Users/cltbld', 15:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:46 INFO - 'LOGNAME': 'cltbld', 15:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:46 INFO - 'MOZ_NO_REMOTE': '1', 15:15:46 INFO - 'NO_EM_RESTART': '1', 15:15:46 INFO - 'PAGER': '/bin/cat', 15:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:46 INFO - 'PWD': '/builds/slave/test', 15:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:46 INFO - 'SHELL': '/bin/bash', 15:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:15:46 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:46 INFO - 'USER': 'cltbld', 15:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:46 INFO - 'XPC_FLAGS': '0x0', 15:15:46 INFO - 'XPC_SERVICE_NAME': '0', 15:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 INFO - Cleaning up... 15:15:47 INFO - Return code: 0 15:15:47 INFO - Running post-action listener: _resource_record_post_action 15:15:47 INFO - Running post-action listener: _start_resource_monitoring 15:15:47 INFO - Starting resource monitoring. 15:15:47 INFO - ##### 15:15:47 INFO - ##### Running install step. 15:15:47 INFO - ##### 15:15:47 INFO - Running pre-action listener: _resource_record_pre_action 15:15:47 INFO - Running main action method: install 15:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:47 INFO - Reading from file tmpfile_stdout 15:15:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:47 INFO - Reading from file tmpfile_stdout 15:15:47 INFO - Output received: 15:15:47 INFO - Usage: mozinstall [options] installer 15:15:47 INFO - Options: 15:15:47 INFO - -h, --help show this help message and exit 15:15:47 INFO - -d DEST, --destination=DEST 15:15:47 INFO - Directory to install application into. [default: 15:15:47 INFO - "/builds/slave/test"] 15:15:47 INFO - --app=APP Application being installed. [default: firefox] 15:15:47 INFO - mkdir: /builds/slave/test/build/application 15:15:47 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:15:47 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:16:18 INFO - Reading from file tmpfile_stdout 15:16:18 INFO - Output received: 15:16:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:16:18 INFO - Running post-action listener: _resource_record_post_action 15:16:18 INFO - ##### 15:16:18 INFO - ##### Running run-tests step. 15:16:18 INFO - ##### 15:16:18 INFO - Running pre-action listener: _resource_record_pre_action 15:16:18 INFO - Running main action method: run_tests 15:16:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:18 INFO - 2015-11-19 15:16:18.060 screenresolution[2219:68041] starting screenresolution argv=screenresolution get 15:16:18 INFO - 2015-11-19 15:16:18.063 screenresolution[2219:68041] Display 0: 1600x1200x32@60 15:16:18 INFO - 2015-11-19 15:16:18.069 screenresolution[2220:68043] starting screenresolution argv=screenresolution list 15:16:18 INFO - Available Modes on Display 0 15:16:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:18 INFO - Intel Iris: 15:16:18 INFO - Chipset Model: Intel Iris 15:16:18 INFO - Type: GPU 15:16:18 INFO - Bus: Built-In 15:16:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:18 INFO - Vendor: Intel (0x8086) 15:16:18 INFO - Device ID: 0x0a2e 15:16:18 INFO - Revision ID: 0x0009 15:16:18 INFO - Displays: 15:16:18 INFO - Display: 15:16:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:18 INFO - Display Serial Number: 1600x1200 60 15:16:18 INFO - Main Display: Yes 15:16:18 INFO - Mirror: Off 15:16:18 INFO - Online: Yes 15:16:18 INFO - Rotation: Supported 15:16:18 INFO - Return code: 0 15:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:18 INFO - Python 2.7.3 15:16:18 INFO - Return code: 0 15:16:18 INFO - grabbing minidump binary from tooltool 15:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:18 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 0x10f9989f0>, '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 0x10f6f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f98b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:18 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:16:18 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:16:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:18 INFO - Return code: 0 15:16:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:16:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:16:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:18 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/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--webServer', 'localhost'] in /builds/slave/test/build 15:16:18 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/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --webServer localhost 15:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QBQQM8vwJp/Render', 15:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:18 INFO - 'HOME': '/Users/cltbld', 15:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:18 INFO - 'LOGNAME': 'cltbld', 15:16:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:18 INFO - 'MOZ_NO_REMOTE': '1', 15:16:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:18 INFO - 'NO_EM_RESTART': '1', 15:16:18 INFO - 'PAGER': '/bin/cat', 15:16:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:18 INFO - 'PWD': '/builds/slave/test', 15:16:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:18 INFO - 'SHELL': '/bin/bash', 15:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OHCR0oMkxm/Listeners', 15:16:18 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 15:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:18 INFO - 'USER': 'cltbld', 15:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:18 INFO - 'XPC_FLAGS': '0x0', 15:16:18 INFO - 'XPC_SERVICE_NAME': '0', 15:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:18 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/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--webServer', 'localhost'] with output_timeout 3600 15:16:18 INFO - mozversion INFO | application_buildid: 20151119131711 15:16:18 INFO - mozversion INFO | application_changeset: a76322320837ac6d0c9510c280706359a47ea309 15:16:18 INFO - mozversion INFO | application_display_name: Nightly 15:16:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:18 INFO - mozversion INFO | application_name: Firefox 15:16:18 INFO - mozversion INFO | application_remotingname: firefox 15:16:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:16:18 INFO - mozversion INFO | application_vendor: Mozilla 15:16:18 INFO - mozversion INFO | application_version: 45.0a1 15:16:18 INFO - mozversion INFO | platform_buildid: 20151119131711 15:16:18 INFO - mozversion INFO | platform_changeset: a76322320837ac6d0c9510c280706359a47ea309 15:16:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:16:18 INFO - mozversion INFO | platform_version: 45.0a1 15:16:18 INFO - 2015-11-19 15:16:18,616 DEBUG : using testdate: 1447974978 15:16:18 INFO - 2015-11-19 15:16:18,616 DEBUG : actual date: 1447974978 15:16:18 INFO - 2015-11-19 15:16:18,626 INFO : starting webserver on 'localhost:53688' 15:16:18 INFO - 2015-11-19 15:16:18,626 INFO : Starting test suite t-yosemite-r7-0012 15:16:18 INFO - 2015-11-19 15:16:18,627 INFO : Starting test dromaeo_css 15:16:18 INFO - 2015-11-19 15:16:18,627 DEBUG : operating with platform_type : mac_ 15:16:18 INFO - 2015-11-19 15:16:18,627 INFO : Initialising browser for dromaeo_css test... 15:16:18 INFO - 2015-11-19 15:16:18,640 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpUlexdI/profile http://localhost:53688/getInfo.html 15:16:20 INFO - 2015-11-19 15:16:20,710 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:16:20 INFO - 2015-11-19 15:16:20,711 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:16:20 INFO - 2015-11-19 15:16:20,711 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:16:20 INFO - 2015-11-19 15:16:20,711 DEBUG : BROWSER_OUTPUT: __metrics 15:16:20 INFO - 2015-11-19 15:16:20,728 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:16:20 INFO - 2015-11-19 15:16:20,989 DEBUG : BROWSER_OUTPUT: console.error: 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: Stack: 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:16:20 INFO - 2015-11-19 15:16:20,990 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 15:16:20 INFO - 2015-11-19 15:16:20,991 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:16:20 INFO - 2015-11-19 15:16:20,991 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 15:16:20 INFO - 2015-11-19 15:16:20,991 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 15:16:20 INFO - 2015-11-19 15:16:20,991 DEBUG : BROWSER_OUTPUT: 15:16:21 INFO - 2015-11-19 15:16:21,398 INFO : Browser initialized. 15:16:21 INFO - 2015-11-19 15:16:21,398 INFO : Running cycle 1/1 for dromaeo_css test... 15:16:21 INFO - 2015-11-19 15:16:21,398 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpUlexdI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:16:33 INFO - 2015-11-19 15:16:33,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 224382976 15:16:33 INFO - 2015-11-19 15:16:33,327 DEBUG : BROWSER_OUTPUT: 15:17:24 INFO - 2015-11-19 15:17:24,274 DEBUG : BROWSER_OUTPUT: 1447975044274 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:19:36 INFO - 2015-11-19 15:19:36,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53688/tests/dromaeo/cssquery-ext.html) 15:19:37 INFO - 2015-11-19 15:19:37,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 377577472 15:19:37 INFO - 2015-11-19 15:19:37,588 DEBUG : BROWSER_OUTPUT: 15:22:40 INFO - 2015-11-19 15:22:40,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-ext.html (next: http://localhost:53688/tests/dromaeo/cssquery-jquery.html) 15:22:41 INFO - 2015-11-19 15:22:41,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 361091072 15:22:41 INFO - 2015-11-19 15:22:41,016 DEBUG : BROWSER_OUTPUT: 15:25:43 INFO - 2015-11-19 15:25:43,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53688/tests/dromaeo/cssquery-mootools.html) 15:25:43 INFO - 2015-11-19 15:25:43,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 343498752 15:25:43 INFO - 2015-11-19 15:25:43,626 DEBUG : BROWSER_OUTPUT: 15:28:45 INFO - 2015-11-19 15:28:45,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53688/tests/dromaeo/cssquery-prototype.html) 15:28:46 INFO - 2015-11-19 15:28:46,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 326979584 15:28:46 INFO - 2015-11-19 15:28:46,304 DEBUG : BROWSER_OUTPUT: 15:31:49 INFO - 2015-11-19 15:31:49,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53688/tests/dromaeo/cssquery-yui.html) 15:31:49 INFO - 2015-11-19 15:31:49,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 325435392 15:31:49 INFO - 2015-11-19 15:31:49,929 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/dromaeo/cssquery-yui.html (next: http://localhost:53688/tests/dromaeo/cssquery-dojo.html) 15:34:53 INFO - 2015-11-19 15:34:53,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 379285504 15:34:53 INFO - 2015-11-19 15:34:53,276 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,277 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:34:53 INFO - 2015-11-19 15:34:53,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:34:53 INFO - 2015-11-19 15:34:53,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:34:53 INFO - 2015-11-19 15:34:53,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:34:53 INFO - 2015-11-19 15:34:53,280 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2886.567014947758;2899.1302609217237;3440.3807314683377;3479.478078288255;3486.041338631876;5712.343080545738;5787.884242315156;5833.70831458427;5841.123831425278;5846.093855452406;5715.199872017921;5822.214001109859;5884.823455296348;5904;5924.703764811753;5273.499017593332;5292.735363231823;5342.198670199482;5375.973120134394;5401.3248343957;5402.8919421611545;5404.351477822667;5407.540359069464;5416.133418653017;5416.160495123262;5349.652272602269;5370.248165256867;5372.328458942632;5378.946210537883;5383.192521121824;5376.247325374451;5384.946150538483;5386.003589335985;5391.029614669358;5410.621256512046;4415.271480205794;4605.769711514411;5200.661956972823;5322.866928326784;5366.409694933554;5773.134029895507;5912.556558258148;5942.494887934531;5985.311689155759;6018.097285407224;6326.177596912418;6337.112804207414;6343.524235682296;6370.108184854124;6376.808695739135;6237.968810155966;6274.403931626533;6342.778002769881;6404.48764098871;6416.358364163593;5980.252468441445;6021.430351358086;6037.909431358533;6045.6070355426755;6068.969655151696;6463.48292136628;6535.477161827042;6536.477081833442;6542.149520562297;6547.705353259114;6100.816975490742;6210.937890621126;6221.346758590374;6244.188255526752;6392.4566411854585;6380.808575742735;6412.166418365583;6413.422791948747;6416.615003099829;6419.325970773095;6224.533160012927;6342.873142537123;6345.175127233522;6349.968250158812;6364.745410183541;5900.645961242253;6241.656708881055;6367.713452894631;6377.553571249968;6410.519211059189;5083.694978301313;5103.693778373309;5106.744662766847;5107.259447380109;5110.514501122388;4551.089782043605;4553.544645535486;4556.384888040138;4577.633789296849;4601.3558101865765;5885.735141918624;5946.286445626466;5997.760089596454;6041.78853740117;6062.818115456544;6359.523035772336;6389.105525226472;6389.6805159741825;6397;6403.263624683128;5906.763729450774;5934.554908381889;5949.583529153005;5955.910661340084;5969.04495280753;5512.145617429305;5518.951399234133;5520.06158952971;5527.917081243784;5529.889402211933;6407.199100112486;6425.421712045938;6534.477241820643;6538.084668146464;6540.574862633914;6383.585066970632;6434.163558737334;6434.935650643433;6439.06633538125;6444.420002199825;6346.936530634634;6413.807585772434;6596.90104648421;6604.306547812603;6605;6186.4741496973265;6260.28006779208;6319.368063193828;6327.303996560283;6328.746850125944;6336.58812177207;6362.1729175208775;6380.585261957958;6390.073439351361;6402.03969404593;6094.664793436404;6167.876642467215;6172.969135154295;6342.365763423621;6342.873142537216;6129.84675383119;6183.81448556544;6188.1027251049245;6193.411625895533;6213.1922850029205;6150.292716337678;6201.255849298113;6206.193194884636;6206.410391012847;6220.284667263322;6124.969375153096;6151.384861513813;6320.810375688737;6351.301356850835;6354.6822658867795;6059.666718330534;6122.825106970275;6128.625347140905;6141.662208578571;6143.447089761943 15:34:53 INFO - 2015-11-19 15:34:53,281 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.9839204823854;547.4552819944156;558.4052983572498;616.8087892753248;643.3662842100532;32149.839250803743;32536.67463325366;32561.67438325616;32590.837045814766;32598.348033039325;42108;42764.572354276446;42838.14323713524;42941.35587966183;42989.570104298946;9719.416834989906;9935.503224838765;9953.05445982634;9956.551955161998;9958;9042.367034307601;9143.634254629807;9161.587728552231;9761.121499065082;9873.259505537078;8985.146411090936;9072.047435019327;9092.63629454821;12016.819747703792;12283.69290767729;11832.822507662391;11912.523499060027;11919.344436056013;11923.642290731292;11974.281543107441;11740.471678774476;11883.762324753456;11886.524539018428;11889.989350905184;11892.821607675893;33933.490997635054;34201.48697769536;34209.4868576969;41380.79309603463;41711.748647540626;3165.8733650653944;3370.79775213488;3543.3799085159994;3832;3840.8847734568008;27365.726342736714;28902.554872256303;29489.85255073711;30748.07755767308;31090.222744431343;2769.6399468069226;2786.122371452986;2817.281593193743;2894.7828912831624;2958.3195864950967;469732;473452;473745.99999999657;473902;474283;69229.65385173041;69840.65079674569;69889.65055174794;69949.65025174842;70061.64969175121;74241.62879185677;74275;74301.62849185828;74322;76694;15703;16830.57923551921;17034.48896533106;17048.57378565521;17070.48788536346;11604.071674266039;11713.414329283502;11726;11742.412879355998;11772.764544709058;17295.913520432317;18267.473652232642;22461.55076898453;22997.88501057484;23051.423714406938;7773.655008667669;9368.578413971387;9583.185429238592;9740.756481087888;9803.921568627446;909.5634095634;978.5449765858767;1101.8126918423886;1110.4947249001684;1140.372794962767;24932.875335623205;29605.371704556026;29744;30165;30269.69730302713;1007.2797949466167;1080.7460246841986;1129.412705393191;1151.850259466264;1183.5798291606527;14213.85786142146;14960.551183464513;15088.622784430478;15270.77093843571;15332.693346133015;535181.6481835132;541709;542586.28706857;542909;543300;59772.402275977554;60010.09984850231;60038.799224015274;60148;60188.398116019154;1204.5242129358853;1252.9373531323397;1462.2323280277726;1468.0751126790053;1605.1733357320988;23619.64570531478;28488.145355639364;28787.28031799222;29504.704952950196;29729.554056689598;50551.74724126503;50983.490165099356;50996.74501627468;51047;51091.744541277054;502769;503199.9680003153;505188;505381;505682.4715876397;28816.567751484163;29261;33208.833955830065;33885.983420497425;33970.49044264387;42425.36361954635;42851.57148428476;42917.570824292605;43332.13335733331;44278;36764.63235367612;37248.6275137256;38084.619153808104;38218.426723599725;38352.04119897025;29809;34240.828795855865;36258.63741362658;36290.03784356277;37028.44457333196;35096.12259693426;35764;36566.26867462689;36687;36825.26349473049;30088.398232035674;32630.83684581562;32637.673623263465;32688;32843.686252550586;24000.03999839987;24401.877990610643;24458.877705611358;24520.38699032467;24550.754492454846 15:34:53 INFO - 2015-11-19 15:34:53,285 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.7580845025382;360.0889748935195;366.21446996193157;366.490578096446;366.65717554086916;16238.431654892081;16588.917055414706;19623.901880490594;20456.590868182626;21190.25834095807;21437.8209198494;21650.592711473742;22129.889350553225;22315.77684223157;22322.21872234472;6194.163787888622;6719.899201511981;6816.318368163169;6857.897131543031;6887.827804304908;6699.497537684669;6750.5498286928105;6799.490038247127;6831.146106736658;6835.248122706498;6712.306227157368;6747.055412242265;6777.491688123386;6790.117284752975;6818.420434263069;6788.592684438925;6824.146981627297;6824.658767061627;6826.761063362758;6831.419329357011;6358;6527.804165875032;6529;6529.477641788693;6538.901916471256;25563.872180638977;25597.23208303754;25702.228933132035;26864.865675671495;27044.864775675996;2231.4867580456425;2317.5944209763393;2442.9129037578286;2488.9377765555823;2574.918534215634;14898.627534311729;15086.265079515886;15529.990550614288;15897.92051039749;16057;1789.3737191982702;1836.7979522252542;1854.6012607289363;1875.41862022772;1883.2655264446876;110400;114632.99999999917;115174;116047.83952160539;117807.41096294549;15539.378424862878;19107.713384299248;19108.522286942658;19134.80865191358;19151.712724309145;24121.03515859346;24731.62902556463;24766.87616561942;28271.43457130846;28291;10012.499375031364;10217.284790064625;10218.795624087477;10245.795084098276;10280.897191028143;8716.302695784321;8775.297976161892;8844.955775221211;8860.8670869937;8891.599878005505;8548;8551.401401901807;8651.783705407415;8666.523341216294;8668.696595619123;2916.83957382346;3133.937321253562;3367.51171080192;3398.439257522481;3447.827608619559;349.25956971220666;387.6530505197832;398.1519363755241;914.5701520285455;1122.5004872831676;11196.608118715805;11889.346085965355;12044.036477081812;12143.332116733665;21576.244831431137;918.8116436130578;951.9666811661697;985.8274801909637;1041.109851077318;1056.3767377247461;9786.217102631772;10359.948200259101;11398.658040258806;11623.59317423886;11805.70137284898;608182;611293;612657;760696;762764;85280;124496.37751811364;133105;133848;135942;1127.8590176227972;1172.5016867831137;1182.9053675705923;1183.7218253710544;1185.6739396665987;18089;18342.724859126858;18346.908265459122;18435.354762583243;18609.464201801613;52936;53632.19551706805;53792.731036344565;53882;54631.18053229284;75461;75935.86096208672;77539.61230194039;77750.6112469434;80441;9711.320207585684;9745.26910481731;9927.702168934944;10057.497125143567;10069.093781559695;11757;11814.468348924147;11864.881351186377;14307.713845723236;20495.897520512302;15690.76463853066;16149;16156.67686646284;16245.51263462098;16414.850960432654;12980.935095324463;15699.293531791325;15906;16050.598735031717;16087.597810054842;16086.758698619764;16133.75799363034;16437.342506299614;16764.89849377869;17015.149242537576;9905.900940990787;10043.397396156253;10048.346857454242;10140.870372311105;10179.694609161737;13967.860321396656;16160.595985099997;16211.51365459038;16602.252898619834;16603.169841507635 15:34:53 INFO - 2015-11-19 15:34:53,285 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1381.4336122189898;1389.6456403617076;1394.086873098121;1678.5635734708976;1939.3697048459255;7601.163871974085;7924.247196516336;7932.524048557083;8206.91793082069;8360.038595561513;8250.587470626475;8351.874721879176;8393.70622028229;8438.409311348209;8445.239928406441;2140.357892632212;2351.811855051596;2369.455025344172;2373.3829204406893;2381.583222935988;2196.363054714139;2202.7797220278003;2366.9881650591724;2393.808495320379;2395.461021270209;2295.850769699964;2337.2871274261342;2341.157183413978;2341.519988402382;2349.2952114365708;2128.372130221588;2177.771334009922;2344.8358614896965;2363.5509253241917;2374.6200607902824;2161.967570486444;2338.0414030247516;2352.364861487406;2353.917612883558;2357.304595144419;8315.916840831635;8396.034456037572;8412.03261624915;8423.957880210559;8439.620217090245;5126.282320475137;5192;5234.581233501311;5237.607179461517;5258.027264955996;3495.965040349615;3531.770434921722;3547.379208638478;3624.746267761258;3627.7823330599986;1065.3767545985609;1068.6847380022912;1634.1502418742186;1650.9174541273007;1681.9411320603842;11066.502007409686;11175.608853690082;11182.496787644575;11188.776224475465;11200.439978001148;4452.9554704453185;4454.710443821141;4534.115847409789;4546.136234115507;4555.498895121534;9012.369134160546;9019.466690662603;9025.05236950124;9035.503047332328;9049.954750226338;5176.352955880515;5197.506236907563;5206.609504287194;5207.479252074762;5208.348956380452;4797.664163508521;4805.063012712488;4843.982763619609;4845.903081938412;4848.539388758062;3449.724022078228;3518.296340731864;3543.344481270973;3562.1985053363305;3575.785452872784;1114.1977776001265;1125.3754166437543;1133.3539882267028;1133.6315697398213;1137.3744440557825;1081.3619964221148;1082.437132691012;1104.3815463340554;1221.985751826;1333.120140707148;6765.898511522331;7892.960535197287;7934.166912474223;7969.083555391204;7969.641366138538;496.85591178558536;509.95665368443355;513.0585375835309;515.5875299760177;519.2107995846293;5845.970770146122;5922.822315330547;5930.22907022093;6183.752649894044;6259.3427690091885;9566.13904748576;9690.806183876424;9767.951160244296;9791.020897910294;9791.46146961924;9551.952240238894;9703.611855525842;9750.073742994404;9810.411375317504;9824.4105353679;7527.2849079337375;7695.961520192475;7778.64996075178;7806.18035106317;7850.6859725611475;7870.606469676608;7901.841963160819;7918.802029949067;7923.801904952422;7928.722494712888;8990.640374384951;9110.498922559058;9189.264858811413;9228.169464748205;9328.300377471582;9257;9456.385334953206;9516.238700903772;9539.856902146335;9554.235661146953;6022.698865056642;6806.6256355900905;6850.177978642595;6913.619750913748;6929.307069293232;7905.6837726492595;7946.960265198637;7966.84066318682;7995.960525131695;8060.83878322442;7388.889166662397;7515.323620874147;7560.848783024198;7679.961600191963;7717.305442510201;7303.342699156889;7369.742059027908;7418.332350088518;7445.739399121005;7521.962390188014;7503.024606801299;7539;7540.8491830164185;7550.395968322631;7573.242675732383;6658.234303055017;6824.146981627297;6885.655717214019;6897.655117244018;6908.620025898624;6412.519061070531;6950.20072691647;6985.511014229159;7005.6146911918295;7010.404115650227 15:34:53 INFO - 2015-11-19 15:34:53,288 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.1749327987153;324.33025801719447;325.70198268584244;330.45639922327774;335.5754969962999;6699.966500167492;6868.62222577758;6884.5525040872435;6959.791206263814;6971.337722916322;5534.225208470817;6822.249552549228;6845.281245469228;6853.4174595159475;6863.656817159134;4971.527704868032;4984.451710311862;5080.466551012146;5112.846614601568;5125.487451254863;4331.8267269309345;4967.875803104933;5064.772085256154;5106.208537676647;5112.8977420451565;5048.1670524363435;5076.695398276097;5088.4911508849;5090.643654944155;5101.821436249732;5048.798048078109;5062.164742817431;5075.21334193197;5076.289319495274;5083.983203359343;4341.978290108529;4347.8695639130565;4350.1734670412525;4355.716878402894;4364.2798938175165;6423.903641445382;6669.366410191024;6679.465642748569;6682.632455214961;6684.799456016327;5946.3459019508255;5952;5956.285245770492;5958;5962;7409.925900740977;7416.629168541552;7417.666205020787;7431.145418276913;7456.813579660497;4523.117991991563;4604.769761511911;4628.745419001953;4637.397138372024;4708.952910470885;7742.806429839243;7851.175626559186;7883.408744344197;7888.802779930547;7896.447248692594;4777.976110119427;4786.042791441726;4790.137775200497;4792.688475249098;4795.664303498722;4719.811207551728;4850.95149048512;4856.1987272099705;4898.461169271377;4911;5899.911501327483;5901.852453688606;5905.763769449174;5914.497267732291;5933.554983376178;7403.9629801851725;7410.666520006613;7417.925820741832;7431.7770466884995;7431.85136297271;1639.4507839873777;1671.7158083125898;1698.3800912666788;1703.1399143432734;1705.7015022371036;1060.4114716332356;1067.770429357692;1081.7674200047027;1082.9458527073614;1087.1737479515625;6906.896396554056;6960.37356637905;6960.617166055814;6963.1644202696;6970.965145174242;7641.656125474367;7648.541087534766;7650.4644674872225;7662;7677.23227677239;6742;6921.861562768817;6928.896066559006;6933.583984960817;6980.232174460805;3327.783694059878;3684.373656478405;3731.421629647409;4108.835646574164;4123.092919557693;6102.755889764359;8074.475159114639;8077.27304542594;8091.312238459797;8099.433039687283;7791.340074592642;7943.64253608589;8018.839623207503;8033.55815430157;8033.638486268132;8068.596570171585;8080.595970201584;8082.232187942253;8096.068952070587;8096.8380632387025;7420.5176663516695;7458.627068646654;7627.321989162376;7736.303732664087;7752;6997.47518936092;7392;7417.92582074194;7512.173660897188;7518.586477743776;8096.51420914747;8109.310708589836;8112.1076681566165;8116.837663246584;8125.349972002344;4672.976635116803;4761.119192949315;4812;4814.398200224972;4816.759162041954;7636.770896873103;7638.2743639356395;7665.463417560717;7668.309852113337;7669.5398276103615;6026.668533230714;7411.62941852916;7415.592142432218;7426.74006409773;7435.591042492715;7143.392811611071;7389.519681220703;7410.6665200065045;7411.370033546993;7411.99938008362;7239.529430586995;7239.8914016288745;7244.818879527843;7251.673674684546;7255.927440725525;7209.0628218331285;7396.186419493959;7398.3341499265325;7422.591757453392;7427.8143046424275;5544.8355845272945;7177.425805935617;7268.418526517971;7268.927310726825;7272 15:34:53 INFO - 2015-11-19 15:34:53,289 DEBUG : BROWSER_OUTPUT: |5;yui.html;717.7308509309009;718.3893690363191;740.8629403560338;815.6778072661299;816;15150.924245378772;15392.307346169422;15405.306761195745;15415.69168616627;15417.920745547815;14181.220032898187;14260.073095248828;14262.71474570508;14264.643383915381;14318.212498312589;740.4224704730319;748.2779118150984;748.3825843678959;748.651876877252;915.7069737683961;928.9396189247711;945.1163162443104;946.2240962410826;947.4457442396207;947.6351604632232;954.5799848066863;990.0495524296648;990.1385794358918;990.2770977186658;990.8563258327538;763.9847203055963;776.4293244465314;784.3215618490023;973.2846357926918;984.1929617713478;626.348597458647;730.9195988441268;732.2787054751119;733.2703959560218;733.6991833348302;14812;14993.475228367064;15013;15018.474353397578;15028.549143525712;12110.636680899586;12456.875431245753;12972.091953563255;13241.205527668371;13349.599512014558;10239.18086553074;10241.385516869012;10367.37795732251;10393.116585090202;10416;3539.8407071681836;3628.455731640275;3707.666310032083;3738.065483629093;3757.1734218471893;83233.16766832375;83319;83978;83982;84081.57959210165;9535.666251681296;9568.665096721581;9835.409875407355;9859;9904.504774761233;21521.246756363453;21624.78375216228;21666.13335466595;21675.024623891964;21688.34934951954;7560.924390756132;7633.0458692663415;7692.307692307719;7782.299593036654;7868.960655196802;3350.966490335114;4068.9389659155136;4113.4858142732155;4150.91698166035;4172.5410204877435;3608.8736894208578;3639.0356555512813;3651.1602331463914;3653.4337177737493;3656.012876523377;633.0851918977125;638.1576319258534;640.3372509452694;644.8516841126567;677.3734295776486;489.6352217597841;513.5891286970483;521.4955499046403;548.1585765849402;647.970841312142;8694.91305086941;8714.172153645393;8833.911660883308;8839.69061082859;8996.235319997742;527.9260903473516;533.6104643610187;601.6420229963165;606.6087373643975;618.8669436071266;3953.802309884494;4134.545200027995;4266.104118135227;4373.6282415994365;4516.299973504112;93829;94920;95298.52350738202;102124;103265.45101823479;81728;83118.58440707758;85623.5718821402;88417.55791221131;90077.7480562978;59661;78252.60873695595;78490;80117;81114.18885811066;9070.455772653662;9108.726738197865;9125.406848554823;9225.12361325673;9238.568021956607;50007;50224;50433.74783126061;50611.24083138682;51086;62900.37099629128;64283.67858160679;65630.67184664046;67773.9833902482;70979.29020709933;11010.559577617127;11115.555377785122;11245.38150401703;11271.661850144508;11506.884931150582;12048.277103373826;12237;12555.35037032623;12569.685757856127;12866.549670761478;11260.887391125983;11295.830562541403;11487.425628718698;11809.645710628694;11846.585369512026;11442;11483.770324593628;11791.88208117908;11845.23006004607;12490.000799936164;8811.396837301667;10397.948010260203;10848.728781780519;11555.88444115548;11672.533098675958;8071.354291656771;9620.807583848424;9731.075547822946;9743.658971935949;9844.753881153028;9761.658341957997;9990.750231244278;10003.899961000589;10017.04497173321;10102.09081182697 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1257 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: __startTimestamp1447976093276__endTimestamp 15:34:53 INFO - 2015-11-19 15:34:53,290 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,291 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:34:53 INFO - 2015-11-19 15:34:53,291 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:34:53 INFO - 2015-11-19 15:34:53,291 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,291 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5889.66 Median:6129.85 stddev:687.31 (11.2%) stddev-sans-first:647.79 15:34:53 INFO - 2015-11-19 15:34:53,292 DEBUG : BROWSER_OUTPUT: Values: 2886.6 2899.1 3440.4 3479.5 3486.0 5712.3 5787.9 5833.7 5841.1 5846.1 5715.2 5822.2 5884.8 5904.0 5924.7 5273.5 5292.7 5342.2 5376.0 5401.3 5402.9 5404.4 5407.5 5416.1 5416.2 5349.7 5370.2 5372.3 5378.9 5383.2 5376.2 5384.9 5386.0 5391.0 5410.6 4415.3 4605.8 5200.7 5322.9 5366.4 5773.1 5912.6 5942.5 5985.3 6018.1 6326.2 6337.1 6343.5 6370.1 6376.8 6238.0 6274.4 6342.8 6404.5 6416.4 5980.3 6021.4 6037.9 6045.6 6069.0 6463.5 6535.5 6536.5 6542.1 6547.7 6100.8 6210.9 6221.3 6244.2 6392.5 6380.8 6412.2 6413.4 6416.6 6419.3 6224.5 6342.9 6345.2 6350.0 6364.7 5900.6 6241.7 6367.7 6377.6 6410.5 5083.7 5103.7 5106.7 5107.3 5110.5 4551.1 4553.5 4556.4 4577.6 4601.4 5885.7 5946.3 5997.8 6041.8 6062.8 6359.5 6389.1 6389.7 6397.0 6403.3 5906.8 5934.6 5949.6 5955.9 5969.0 5512.1 5519.0 5520.1 5527.9 5529.9 6407.2 6425.4 6534.5 6538.1 6540.6 6383.6 6434.2 6434.9 6439.1 6444.4 6346.9 6413.8 6596.9 6604.3 6605.0 6186.5 6260.3 6319.4 6327.3 6328.7 6336.6 6362.2 6380.6 6390.1 6402.0 6094.7 6167.9 6173.0 6342.4 6342.9 6129.8 6183.8 6188.1 6193.4 6213.2 6150.3 6201.3 6206.2 6206.4 6220.3 6125.0 6151.4 6320.8 6351.3 6354.7 6059.7 6122.8 6128.6 6141.7 6143.4 15:34:53 INFO - 2015-11-19 15:34:53,292 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,292 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65291.95 Median:34225.16 stddev:134875.71 (394.1%) stddev-sans-first:135166.44 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: Values: 536.0 547.5 558.4 616.8 643.4 32149.8 32536.7 32561.7 32590.8 32598.3 42108.0 42764.6 42838.1 42941.4 42989.6 9719.4 9935.5 9953.1 9956.6 9958.0 9042.4 9143.6 9161.6 9761.1 9873.3 8985.1 9072.0 9092.6 12016.8 12283.7 11832.8 11912.5 11919.3 11923.6 11974.3 11740.5 11883.8 11886.5 11890.0 11892.8 33933.5 34201.5 34209.5 41380.8 41711.7 3165.9 3370.8 3543.4 3832.0 3840.9 27365.7 28902.6 29489.9 30748.1 31090.2 2769.6 2786.1 2817.3 2894.8 2958.3 469732.0 473452.0 473746.0 473902.0 474283.0 69229.7 69840.7 69889.7 69949.7 70061.6 74241.6 74275.0 74301.6 74322.0 76694.0 15703.0 16830.6 17034.5 17048.6 17070.5 11604.1 11713.4 11726.0 11742.4 11772.8 17295.9 18267.5 22461.6 22997.9 23051.4 7773.7 9368.6 9583.2 9740.8 9803.9 909.6 978.5 1101.8 1110.5 1140.4 24932.9 29605.4 29744.0 30165.0 30269.7 1007.3 1080.7 1129.4 1151.9 1183.6 14213.9 14960.6 15088.6 15270.8 15332.7 535181.6 541709.0 542586.3 542909.0 543300.0 59772.4 60010.1 60038.8 60148.0 60188.4 1204.5 1252.9 1462.2 1468.1 1605.2 23619.6 28488.1 28787.3 29504.7 29729.6 50551.7 50983.5 50996.7 51047.0 51091.7 502769.0 503200.0 505188.0 505381.0 505682.5 28816.6 29261.0 33208.8 33886.0 33970.5 42425.4 42851.6 42917.6 43332.1 44278.0 36764.6 37248.6 38084.6 38218.4 38352.0 29809.0 34240.8 36258.6 36290.0 37028.4 35096.1 35764.0 36566.3 36687.0 36825.3 30088.4 32630.8 32637.7 32688.0 32843.7 24000.0 24401.9 24458.9 24520.4 24550.8 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38317.50 Median:12273.63 stddev:111598.57 (909.3%) stddev-sans-first:111875.23 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: Values: 355.8 360.1 366.2 366.5 366.7 16238.4 16588.9 19623.9 20456.6 21190.3 21437.8 21650.6 22129.9 22315.8 22322.2 6194.2 6719.9 6816.3 6857.9 6887.8 6699.5 6750.5 6799.5 6831.1 6835.2 6712.3 6747.1 6777.5 6790.1 6818.4 6788.6 6824.1 6824.7 6826.8 6831.4 6358.0 6527.8 6529.0 6529.5 6538.9 25563.9 25597.2 25702.2 26864.9 27044.9 2231.5 2317.6 2442.9 2488.9 2574.9 14898.6 15086.3 15530.0 15897.9 16057.0 1789.4 1836.8 1854.6 1875.4 1883.3 110400.0 114633.0 115174.0 116047.8 117807.4 15539.4 19107.7 19108.5 19134.8 19151.7 24121.0 24731.6 24766.9 28271.4 28291.0 10012.5 10217.3 10218.8 10245.8 10280.9 8716.3 8775.3 8845.0 8860.9 8891.6 8548.0 8551.4 8651.8 8666.5 8668.7 2916.8 3133.9 3367.5 3398.4 3447.8 349.3 387.7 398.2 914.6 1122.5 11196.6 11889.3 12044.0 12143.3 21576.2 918.8 952.0 985.8 1041.1 1056.4 9786.2 10359.9 11398.7 11623.6 11805.7 608182.0 611293.0 612657.0 760696.0 762764.0 85280.0 124496.4 133105.0 133848.0 135942.0 1127.9 1172.5 1182.9 1183.7 1185.7 18089.0 18342.7 18346.9 18435.4 18609.5 52936.0 53632.2 53792.7 53882.0 54631.2 75461.0 75935.9 77539.6 77750.6 80441.0 9711.3 9745.3 9927.7 10057.5 10069.1 11757.0 11814.5 11864.9 14307.7 20495.9 15690.8 16149.0 16156.7 16245.5 16414.9 12980.9 15699.3 15906.0 16050.6 16087.6 16086.8 16133.8 16437.3 16764.9 17015.1 9905.9 10043.4 10048.3 10140.9 10179.7 13967.9 16160.6 16211.5 16602.3 16603.2 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,294 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5764.50 Median:6335.93 stddev:3012.70 (47.5%) stddev-sans-first:3003.14 15:34:53 INFO - 2015-11-19 15:34:53,295 DEBUG : BROWSER_OUTPUT: Values: 1381.4 1389.6 1394.1 1678.6 1939.4 7601.2 7924.2 7932.5 8206.9 8360.0 8250.6 8351.9 8393.7 8438.4 8445.2 2140.4 2351.8 2369.5 2373.4 2381.6 2196.4 2202.8 2367.0 2393.8 2395.5 2295.9 2337.3 2341.2 2341.5 2349.3 2128.4 2177.8 2344.8 2363.6 2374.6 2162.0 2338.0 2352.4 2353.9 2357.3 8315.9 8396.0 8412.0 8424.0 8439.6 5126.3 5192.0 5234.6 5237.6 5258.0 3496.0 3531.8 3547.4 3624.7 3627.8 1065.4 1068.7 1634.2 1650.9 1681.9 11066.5 11175.6 11182.5 11188.8 11200.4 4453.0 4454.7 4534.1 4546.1 4555.5 9012.4 9019.5 9025.1 9035.5 9050.0 5176.4 5197.5 5206.6 5207.5 5208.3 4797.7 4805.1 4844.0 4845.9 4848.5 3449.7 3518.3 3543.3 3562.2 3575.8 1114.2 1125.4 1133.4 1133.6 1137.4 1081.4 1082.4 1104.4 1222.0 1333.1 6765.9 7893.0 7934.2 7969.1 7969.6 496.9 510.0 513.1 515.6 519.2 5846.0 5922.8 5930.2 6183.8 6259.3 9566.1 9690.8 9768.0 9791.0 9791.5 9552.0 9703.6 9750.1 9810.4 9824.4 7527.3 7696.0 7778.6 7806.2 7850.7 7870.6 7901.8 7918.8 7923.8 7928.7 8990.6 9110.5 9189.3 9228.2 9328.3 9257.0 9456.4 9516.2 9539.9 9554.2 6022.7 6806.6 6850.2 6913.6 6929.3 7905.7 7947.0 7966.8 7996.0 8060.8 7388.9 7515.3 7560.8 7680.0 7717.3 7303.3 7369.7 7418.3 7445.7 7522.0 7503.0 7539.0 7540.8 7550.4 7573.2 6658.2 6824.1 6885.7 6897.7 6908.6 6412.5 6950.2 6985.5 7005.6 7010.4 15:34:53 INFO - 2015-11-19 15:34:53,296 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,296 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6028.97 Median:6876.59 stddev:1964.10 (28.6%) stddev-sans-first:1922.29 15:34:53 INFO - 2015-11-19 15:34:53,297 DEBUG : BROWSER_OUTPUT: Values: 319.2 324.3 325.7 330.5 335.6 6700.0 6868.6 6884.6 6959.8 6971.3 5534.2 6822.2 6845.3 6853.4 6863.7 4971.5 4984.5 5080.5 5112.8 5125.5 4331.8 4967.9 5064.8 5106.2 5112.9 5048.2 5076.7 5088.5 5090.6 5101.8 5048.8 5062.2 5075.2 5076.3 5084.0 4342.0 4347.9 4350.2 4355.7 4364.3 6423.9 6669.4 6679.5 6682.6 6684.8 5946.3 5952.0 5956.3 5958.0 5962.0 7409.9 7416.6 7417.7 7431.1 7456.8 4523.1 4604.8 4628.7 4637.4 4709.0 7742.8 7851.2 7883.4 7888.8 7896.4 4778.0 4786.0 4790.1 4792.7 4795.7 4719.8 4851.0 4856.2 4898.5 4911.0 5899.9 5901.9 5905.8 5914.5 5933.6 7404.0 7410.7 7417.9 7431.8 7431.9 1639.5 1671.7 1698.4 1703.1 1705.7 1060.4 1067.8 1081.8 1082.9 1087.2 6906.9 6960.4 6960.6 6963.2 6971.0 7641.7 7648.5 7650.5 7662.0 7677.2 6742.0 6921.9 6928.9 6933.6 6980.2 3327.8 3684.4 3731.4 4108.8 4123.1 6102.8 8074.5 8077.3 8091.3 8099.4 7791.3 7943.6 8018.8 8033.6 8033.6 8068.6 8080.6 8082.2 8096.1 8096.8 7420.5 7458.6 7627.3 7736.3 7752.0 6997.5 7392.0 7417.9 7512.2 7518.6 8096.5 8109.3 8112.1 8116.8 8125.3 4673.0 4761.1 4812.0 4814.4 4816.8 7636.8 7638.3 7665.5 7668.3 7669.5 6026.7 7411.6 7415.6 7426.7 7435.6 7143.4 7389.5 7410.7 7411.4 7412.0 7239.5 7239.9 7244.8 7251.7 7255.9 7209.1 7396.2 7398.3 7422.6 7427.8 5544.8 7177.4 7268.4 7268.9 7272.0 15:34:53 INFO - 2015-11-19 15:34:53,297 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,297 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18997.80 Median:30131.32 stddev:27128.62 (90.0%) stddev-sans-first:27170.00 15:34:53 INFO - 2015-11-19 15:34:53,299 DEBUG : BROWSER_OUTPUT: Values: 717.7 718.4 740.9 815.7 816.0 15150.9 15392.3 15405.3 15415.7 15417.9 14181.2 14260.1 14262.7 14264.6 14318.2 740.4 748.3 748.4 748.7 915.7 928.9 945.1 946.2 947.4 947.6 954.6 990.0 990.1 990.3 990.9 764.0 776.4 784.3 973.3 984.2 626.3 730.9 732.3 733.3 733.7 14812.0 14993.5 15013.0 15018.5 15028.5 12110.6 12456.9 12972.1 13241.2 13349.6 10239.2 10241.4 10367.4 10393.1 10416.0 3539.8 3628.5 3707.7 3738.1 3757.2 83233.2 83319.0 83978.0 83982.0 84081.6 9535.7 9568.7 9835.4 9859.0 9904.5 21521.2 21624.8 21666.1 21675.0 21688.3 7560.9 7633.0 7692.3 7782.3 7869.0 3351.0 4068.9 4113.5 4150.9 4172.5 3608.9 3639.0 3651.2 3653.4 3656.0 633.1 638.2 640.3 644.9 677.4 489.6 513.6 521.5 548.2 648.0 8694.9 8714.2 8833.9 8839.7 8996.2 527.9 533.6 601.6 606.6 618.9 3953.8 4134.5 4266.1 4373.6 4516.3 93829.0 94920.0 95298.5 102124.0 103265.5 81728.0 83118.6 85623.6 88417.6 90077.7 59661.0 78252.6 78490.0 80117.0 81114.2 9070.5 9108.7 9125.4 9225.1 9238.6 50007.0 50224.0 50433.7 50611.2 51086.0 62900.4 64283.7 65630.7 67774.0 70979.3 11010.6 11115.6 11245.4 11271.7 11506.9 12048.3 12237.0 12555.4 12569.7 12866.5 11260.9 11295.8 11487.4 11809.6 11846.6 11442.0 11483.8 11791.9 11845.2 12490.0 8811.4 10397.9 10848.7 11555.9 11672.5 8071.4 9620.8 9731.1 9743.7 9844.8 9761.7 9990.8 10003.9 10017.0 10102.1 15:34:53 INFO - 2015-11-19 15:34:53,299 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:34:53 INFO - 2015-11-19 15:34:53,299 DEBUG : BROWSER_OUTPUT: 15:34:53 INFO - 2015-11-19 15:34:53,733 INFO : Browser exited with error code: 0 15:34:53 INFO - 2015-11-19 15:34:53,755 INFO : Completed test dromaeo_css (00:18:35) 15:34:53 INFO - 2015-11-19 15:34:53,756 INFO : Starting test kraken 15:34:53 INFO - 2015-11-19 15:34:53,756 DEBUG : operating with platform_type : mac_ 15:34:53 INFO - 2015-11-19 15:34:53,756 INFO : Initialising browser for kraken test... 15:34:53 INFO - 2015-11-19 15:34:53,768 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpR1bgrO/profile http://localhost:53688/getInfo.html 15:34:55 INFO - 2015-11-19 15:34:55,763 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:34:55 INFO - 2015-11-19 15:34:55,764 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:34:55 INFO - 2015-11-19 15:34:55,764 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:34:55 INFO - 2015-11-19 15:34:55,764 DEBUG : BROWSER_OUTPUT: __metrics 15:34:55 INFO - 2015-11-19 15:34:55,780 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:34:56 INFO - 2015-11-19 15:34:56,432 INFO : Browser initialized. 15:34:56 INFO - 2015-11-19 15:34:56,433 INFO : Running cycle 1/1 for kraken test... 15:34:56 INFO - 2015-11-19 15:34:56,433 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpR1bgrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:35:08 INFO - 2015-11-19 15:35:08,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 226213888 15:35:08 INFO - 2015-11-19 15:35:08,353 DEBUG : BROWSER_OUTPUT: 15:35:10 INFO - 2015-11-19 15:35:10,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53688/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:11 INFO - 2015-11-19 15:35:11,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 276537344 15:35:11 INFO - 2015-11-19 15:35:11,448 DEBUG : BROWSER_OUTPUT: 15:35:13 INFO - 2015-11-19 15:35:13,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53688/tests/kraken/driver.html?testName=audio-dft) 15:35:14 INFO - 2015-11-19 15:35:14,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 290037760 15:35:14 INFO - 2015-11-19 15:35:14,582 DEBUG : BROWSER_OUTPUT: 15:35:17 INFO - 2015-11-19 15:35:17,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53688/tests/kraken/driver.html?testName=audio-fft) 15:35:18 INFO - 2015-11-19 15:35:18,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 275963904 15:35:18 INFO - 2015-11-19 15:35:18,516 DEBUG : BROWSER_OUTPUT: 15:35:20 INFO - 2015-11-19 15:35:20,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53688/tests/kraken/driver.html?testName=audio-oscillator) 15:35:21 INFO - 2015-11-19 15:35:21,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 278814720 15:35:21 INFO - 2015-11-19 15:35:21,077 DEBUG : BROWSER_OUTPUT: 15:35:23 INFO - 2015-11-19 15:35:23,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:23 INFO - 2015-11-19 15:35:23,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 279064576 15:35:23 INFO - 2015-11-19 15:35:23,642 DEBUG : BROWSER_OUTPUT: 15:35:26 INFO - 2015-11-19 15:35:26,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53688/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:27 INFO - 2015-11-19 15:35:27,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 282001408 15:35:27 INFO - 2015-11-19 15:35:27,009 DEBUG : BROWSER_OUTPUT: 15:35:29 INFO - 2015-11-19 15:35:29,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53688/tests/kraken/driver.html?testName=imaging-desaturate) 15:35:30 INFO - 2015-11-19 15:35:30,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 281276416 15:35:30 INFO - 2015-11-19 15:35:30,377 DEBUG : BROWSER_OUTPUT: 15:35:33 INFO - 2015-11-19 15:35:33,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53688/tests/kraken/driver.html?testName=json-parse-financial) 15:35:33 INFO - 2015-11-19 15:35:33,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 281329664 15:35:33 INFO - 2015-11-19 15:35:33,629 DEBUG : BROWSER_OUTPUT: 15:35:35 INFO - 2015-11-19 15:35:35,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:35 INFO - 2015-11-19 15:35:35,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 315834368 15:35:35 INFO - 2015-11-19 15:35:35,716 DEBUG : BROWSER_OUTPUT: 15:35:37 INFO - 2015-11-19 15:35:37,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:38 INFO - 2015-11-19 15:35:38,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 315977728 15:35:38 INFO - 2015-11-19 15:35:38,116 DEBUG : BROWSER_OUTPUT: 15:35:40 INFO - 2015-11-19 15:35:40,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:40 INFO - 2015-11-19 15:35:40,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 323129344 15:35:40 INFO - 2015-11-19 15:35:40,736 DEBUG : BROWSER_OUTPUT: 15:35:43 INFO - 2015-11-19 15:35:43,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:43 INFO - 2015-11-19 15:35:43,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 323551232 15:35:43 INFO - 2015-11-19 15:35:43,862 DEBUG : BROWSER_OUTPUT: 15:35:46 INFO - 2015-11-19 15:35:46,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:46 INFO - 2015-11-19 15:35:46,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 324218880 15:35:46 INFO - 2015-11-19 15:35:46,835 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53688/tests/kraken/driver.html?testName=ai-astar) 15:35:48 INFO - 2015-11-19 15:35:48,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 383602688 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;109;110;108;109;107;109;109;123 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;120;141;155;116;141;140;118;159;116 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;183;183;180;185;185;183;187;260;206 15:35:48 INFO - 2015-11-19 15:35:48,718 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;70;76;92;81;81;67;72;72;54 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;79;82;120;75;75;74;114;74;76;116 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;87;91;132;87;89;87;88;87;89 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;95;95;95;96;96;94;93;93;93 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;84;83;85;85;86;87;86;84;86 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;54;56;55;53;55;55;65;52;53 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;65;64;65;67;67;68;68;68 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;81;82;85;81;81;81;81;80 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;121;128;122;121;123;119;125;118;118 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;123;132;135;133;122;133;132;133;121 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;64;62;61;63;65;57;55;65 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:35:48 INFO - 2015-11-19 15:35:48,719 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1063 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: __startTimestamp1447976148712__endTimestamp 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:109.50 stddev:4.53 (4.1%) stddev-sans-first:4.80 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 108.0 109.0 107.0 109.0 109.0 123.0 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.60 Median:141.00 stddev:16.77 (11.9%) stddev-sans-first:16.96 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: Values: 150.0 120.0 141.0 155.0 116.0 141.0 140.0 118.0 159.0 116.0 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,720 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.50 Median:185.00 stddev:24.47 (13.2%) stddev-sans-first:25.66 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: Values: 183.0 183.0 183.0 180.0 185.0 185.0 183.0 187.0 260.0 206.0 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:72.60 Median:74.00 stddev:10.79 (14.6%) stddev-sans-first:10.60 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: Values: 61.0 70.0 76.0 92.0 81.0 81.0 67.0 72.0 72.0 54.0 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.50 Median:75.00 stddev:19.64 (26.2%) stddev-sans-first:20.53 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 120.0 75.0 75.0 74.0 114.0 74.0 76.0 116.0 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:13.94 (15.8%) stddev-sans-first:14.69 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 91.0 132.0 87.0 89.0 87.0 88.0 87.0 89.0 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,721 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.24 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 94.0 93.0 93.0 93.0 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.20 (1.4%) stddev-sans-first:1.27 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 83.0 85.0 85.0 86.0 87.0 86.0 84.0 86.0 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.63 (6.6%) stddev-sans-first:3.84 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: Values: 56.0 54.0 56.0 55.0 53.0 55.0 55.0 65.0 52.0 53.0 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.72 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 64.0 65.0 67.0 67.0 68.0 68.0 68.0 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:1.43 (1.8%) stddev-sans-first:1.42 15:35:48 INFO - 2015-11-19 15:35:48,722 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 81.0 82.0 85.0 81.0 81.0 81.0 81.0 80.0 15:35:48 INFO - 2015-11-19 15:35:48,723 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,723 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:3.13 (2.6%) stddev-sans-first:3.32 15:35:48 INFO - 2015-11-19 15:35:48,723 DEBUG : BROWSER_OUTPUT: Values: 121.0 121.0 128.0 122.0 121.0 123.0 119.0 125.0 118.0 118.0 15:35:48 INFO - 2015-11-19 15:35:48,723 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,723 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.70 Median:133.00 stddev:5.40 (4.1%) stddev-sans-first:5.59 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: Values: 133.0 123.0 132.0 135.0 133.0 122.0 133.0 132.0 133.0 121.0 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:64.00 stddev:3.61 (5.6%) stddev-sans-first:3.56 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 64.0 62.0 61.0 63.0 65.0 57.0 55.0 65.0 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:35:48 INFO - 2015-11-19 15:35:48,724 DEBUG : BROWSER_OUTPUT: 15:35:49 INFO - 2015-11-19 15:35:49,316 INFO : Browser exited with error code: 0 15:35:49 INFO - 2015-11-19 15:35:49,362 INFO : Completed test kraken (00:00:55) 15:35:49 INFO - 2015-11-19 15:35:49,362 INFO : Starting test v8_7 15:35:49 INFO - 2015-11-19 15:35:49,362 DEBUG : operating with platform_type : mac_ 15:35:49 INFO - 2015-11-19 15:35:49,363 INFO : Initialising browser for v8_7 test... 15:35:49 INFO - 2015-11-19 15:35:49,374 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpfADRX2/profile http://localhost:53688/getInfo.html 15:35:51 INFO - 2015-11-19 15:35:51,266 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:35:51 INFO - 2015-11-19 15:35:51,266 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:35:51 INFO - 2015-11-19 15:35:51,266 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:35:51 INFO - 2015-11-19 15:35:51,266 DEBUG : BROWSER_OUTPUT: __metrics 15:35:51 INFO - 2015-11-19 15:35:51,282 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:35:51 INFO - 2015-11-19 15:35:51,916 INFO : Browser initialized. 15:35:51 INFO - 2015-11-19 15:35:51,917 INFO : Running cycle 1/1 for v8_7 test... 15:35:51 INFO - 2015-11-19 15:35:51,917 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpfADRX2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:36:03 INFO - 2015-11-19 15:36:03,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 224292864 15:36:03 INFO - 2015-11-19 15:36:03,705 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53688/tests/v8_7/run.html (next: http://localhost:53688/tests/v8_7/run.html) 15:36:25 INFO - 2015-11-19 15:36:25,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 633499648 15:36:25 INFO - 2015-11-19 15:36:25,334 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |0;Richards;147.49262536873155 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.6678907871627 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.06271379703537 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4780.952380952381 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1714.041095890411 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |5;Earley;949.667616334283 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |6;Boyer;12530.864197530864 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |7;RegExp;28138.88888888889 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |8;Splay;717.8750897343862 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4529.411764705882 15:36:25 INFO - 2015-11-19 15:36:25,335 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: __startTimestamp1447976185331__endTimestamp 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.49 Median:147.49 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: Values: 147.5 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.67 Median:159.67 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: Values: 159.7 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: Values: 285.1 15:36:25 INFO - 2015-11-19 15:36:25,336 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4780.95 Median:4780.95 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: Values: 4781.0 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1714.04 Median:1714.04 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: Values: 1714.0 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: Values: 949.7 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12530.86 Median:12530.86 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: Values: 12530.9 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28138.89 Median:28138.89 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: Values: 28138.9 15:36:25 INFO - 2015-11-19 15:36:25,337 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:717.88 Median:717.88 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: Values: 717.9 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4529.41 Median:4529.41 stddev:0.00 (0.0%) 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: Values: 4529.4 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:36:25 INFO - 2015-11-19 15:36:25,338 DEBUG : BROWSER_OUTPUT: 15:36:25 INFO - 2015-11-19 15:36:25,968 INFO : Browser exited with error code: 0 15:36:25 INFO - 2015-11-19 15:36:25,986 INFO : Completed test v8_7 (00:00:36) 15:36:26 INFO - 2015-11-19 15:36:26,415 INFO : Completed test suite (00:20:07) 15:36:26 INFO - 2015-11-19 15:36:26,415 DEBUG : Working with test: dromaeo_css 15:36:26 INFO - 2015-11-19 15:36:26,415 DEBUG : Generating results file: dromaeo_css 15:36:26 INFO - 2015-11-19 15:36:26,416 DEBUG : Working with test: kraken 15:36:26 INFO - 2015-11-19 15:36:26,416 DEBUG : Generating results file: kraken 15:36:26 INFO - 2015-11-19 15:36:26,416 INFO : javascript benchmark 15:36:26 INFO - 2015-11-19 15:36:26,416 DEBUG : Working with test: v8_7 15:36:26 INFO - 2015-11-19 15:36:26,416 DEBUG : Generating results file: v8_7 15:36:26 INFO - 2015-11-19 15:36:26,416 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:36:26 INFO - 2015-11-19 15:36:26,804 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 15:36:26 INFO - 2015-11-19 15:36:26,804 DEBUG : process_Request line: dromaeo_css 7811.93 graph.html#tests=[[72,1,59]] 15:36:26 INFO - 2015-11-19 15:36:26,804 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:36:26 INFO - 2015-11-19 15:36:26,828 DEBUG : process_Request line: kraken 1389.40 graph.html#tests=[[232,1,59]] 15:36:26 INFO - 2015-11-19 15:36:26,828 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:36:26 INFO - 2015-11-19 15:36:26,857 DEBUG : process_Request line: v8_7 20032.62 graph.html#tests=[[230,1,59]] 15:36:26 INFO - 2015-11-19 15:36:26,858 INFO : javascript benchmark 15:36:26 INFO - 2015-11-19 15:36:26,860 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2886.567014947758, 2899.1302609217237, 3440.3807314683377, 3479.478078288255, 3486.041338631876, 5712.343080545738, 5787.884242315156, 5833.70831458427, 5841.123831425278, 5846.093855452406, 5715.199872017921, 5822.214001109859, 5884.823455296348, 5904.0, 5924.703764811753, 5273.499017593332, 5292.735363231823, 5342.198670199482, 5375.973120134394, 5401.3248343957, 5402.8919421611545, 5404.351477822667, 5407.540359069464, 5416.133418653017, 5416.160495123262, 5349.652272602269, 5370.248165256867, 5372.328458942632, 5378.946210537883, 5383.192521121824, 5376.247325374451, 5384.946150538483, 5386.003589335985, 5391.029614669358, 5410.621256512046, 4415.271480205794, 4605.769711514411, 5200.661956972823, 5322.866928326784, 5366.409694933554, 5773.134029895507, 5912.556558258148, 5942.494887934531, 5985.311689155759, 6018.097285407224, 6326.177596912418, 6337.112804207414, 6343.524235682296, 6370.108184854124, 6376.808695739135, 6237.968810155966, 6274.403931626533, 6342.778002769881, 6404.48764098871, 6416.358364163593, 5980.252468441445, 6021.430351358086, 6037.909431358533, 6045.6070355426755, 6068.969655151696, 6463.48292136628, 6535.477161827042, 6536.477081833442, 6542.149520562297, 6547.705353259114, 6100.816975490742, 6210.937890621126, 6221.346758590374, 6244.188255526752, 6392.4566411854585, 6380.808575742735, 6412.166418365583, 6413.422791948747, 6416.615003099829, 6419.325970773095, 6224.533160012927, 6342.873142537123, 6345.175127233522, 6349.968250158812, 6364.745410183541, 5900.645961242253, 6241.656708881055, 6367.713452894631, 6377.553571249968, 6410.519211059189, 5083.694978301313, 5103.693778373309, 5106.744662766847, 5107.259447380109, 5110.514501122388, 4551.089782043605, 4553.544645535486, 4556.384888040138, 4577.633789296849, 4601.3558101865765, 5885.735141918624, 5946.286445626466, 5997.760089596454, 6041.78853740117, 6062.818115456544, 6359.523035772336, 6389.105525226472, 6389.6805159741825, 6397.0, 6403.263624683128, 5906.763729450774, 5934.554908381889, 5949.583529153005, 5955.910661340084, 5969.04495280753, 5512.145617429305, 5518.951399234133, 5520.06158952971, 5527.917081243784, 5529.889402211933, 6407.199100112486, 6425.421712045938, 6534.477241820643, 6538.084668146464, 6540.574862633914, 6383.585066970632, 6434.163558737334, 6434.935650643433, 6439.06633538125, 6444.420002199825, 6346.936530634634, 6413.807585772434, 6596.90104648421, 6604.306547812603, 6605.0, 6186.4741496973265, 6260.28006779208, 6319.368063193828, 6327.303996560283, 6328.746850125944, 6336.58812177207, 6362.1729175208775, 6380.585261957958, 6390.073439351361, 6402.03969404593, 6094.664793436404, 6167.876642467215, 6172.969135154295, 6342.365763423621, 6342.873142537216, 6129.84675383119, 6183.81448556544, 6188.1027251049245, 6193.411625895533, 6213.1922850029205, 6150.292716337678, 6201.255849298113, 6206.193194884636, 6206.410391012847, 6220.284667263322, 6124.969375153096, 6151.384861513813, 6320.810375688737, 6351.301356850835, 6354.6822658867795, 6059.666718330534, 6122.825106970275, 6128.625347140905, 6141.662208578571, 6143.447089761943], "unit": "ms", "name": "dojo.html", "value": 5841.694082672187}, {"lowerIsBetter": false, "replicates": [535.9839204823854, 547.4552819944156, 558.4052983572498, 616.8087892753248, 643.3662842100532, 32149.839250803743, 32536.67463325366, 32561.67438325616, 32590.837045814766, 32598.348033039325, 42108.0, 42764.572354276446, 42838.14323713524, 42941.35587966183, 42989.570104298946, 9719.416834989906, 9935.503224838765, 9953.05445982634, 9956.551955161998, 9958.0, 9042.367034307601, 9143.634254629807, 9161.587728552231, 9761.121499065082, 9873.259505537078, 8985.146411090936, 9072.047435019327, 9092.63629454821, 12016.819747703792, 12283.69290767729, 11832.822507662391, 11912.523499060027, 11919.344436056013, 11923.642290731292, 11974.281543107441, 11740.471678774476, 11883.762324753456, 11886.524539018428, 11889.989350905184, 11892.821607675893, 33933.490997635054, 34201.48697769536, 34209.4868576969, 41380.79309603463, 41711.748647540626, 3165.8733650653944, 3370.79775213488, 3543.3799085159994, 3832.0, 3840.8847734568008, 27365.726342736714, 28902.554872256303, 29489.85255073711, 30748.07755767308, 31090.222744431343, 2769.6399468069226, 2786.122371452986, 2817.281593193743, 2894.7828912831624, 2958.3195864950967, 469732.0, 473452.0, 473745.99999999657, 473902.0, 474283.0, 69229.65385173041, 69840.65079674569, 69889.65055174794, 69949.65025174842, 70061.64969175121, 74241.62879185677, 74275.0, 74301.62849185828, 74322.0, 76694.0, 15703.0, 16830.57923551921, 17034.48896533106, 17048.57378565521, 17070.48788536346, 11604.071674266039, 11713.414329283502, 11726.0, 11742.412879355998, 11772.764544709058, 17295.913520432317, 18267.473652232642, 22461.55076898453, 22997.88501057484, 23051.423714406938, 7773.655008667669, 9368.578413971387, 9583.185429238592, 9740.756481087888, 9803.921568627446, 909.5634095634, 978.5449765858767, 1101.8126918423886, 1110.4947249001684, 1140.372794962767, 24932.875335623205, 29605.371704556026, 29744.0, 30165.0, 30269.69730302713, 1007.2797949466167, 1080.7460246841986, 1129.412705393191, 1151.850259466264, 1183.5798291606527, 14213.85786142146, 14960.551183464513, 15088.622784430478, 15270.77093843571, 15332.693346133015, 535181.6481835132, 541709.0, 542586.28706857, 542909.0, 543300.0, 59772.402275977554, 60010.09984850231, 60038.799224015274, 60148.0, 60188.398116019154, 1204.5242129358853, 1252.9373531323397, 1462.2323280277726, 1468.0751126790053, 1605.1733357320988, 23619.64570531478, 28488.145355639364, 28787.28031799222, 29504.704952950196, 29729.554056689598, 50551.74724126503, 50983.490165099356, 50996.74501627468, 51047.0, 51091.744541277054, 502769.0, 503199.9680003153, 505188.0, 505381.0, 505682.4715876397, 28816.567751484163, 29261.0, 33208.833955830065, 33885.983420497425, 33970.49044264387, 42425.36361954635, 42851.57148428476, 42917.570824292605, 43332.13335733331, 44278.0, 36764.63235367612, 37248.6275137256, 38084.619153808104, 38218.426723599725, 38352.04119897025, 29809.0, 34240.828795855865, 36258.63741362658, 36290.03784356277, 37028.44457333196, 35096.12259693426, 35764.0, 36566.26867462689, 36687.0, 36825.26349473049, 30088.398232035674, 32630.83684581562, 32637.673623263465, 32688.0, 32843.686252550586, 24000.03999839987, 24401.877990610643, 24458.877705611358, 24520.38699032467, 24550.754492454846], "unit": "ms", "name": "ext.html", "value": 20181.943340100373}, {"lowerIsBetter": false, "replicates": [355.7580845025382, 360.0889748935195, 366.21446996193157, 366.490578096446, 366.65717554086916, 16238.431654892081, 16588.917055414706, 19623.901880490594, 20456.590868182626, 21190.25834095807, 21437.8209198494, 21650.592711473742, 22129.889350553225, 22315.77684223157, 22322.21872234472, 6194.163787888622, 6719.899201511981, 6816.318368163169, 6857.897131543031, 6887.827804304908, 6699.497537684669, 6750.5498286928105, 6799.490038247127, 6831.146106736658, 6835.248122706498, 6712.306227157368, 6747.055412242265, 6777.491688123386, 6790.117284752975, 6818.420434263069, 6788.592684438925, 6824.146981627297, 6824.658767061627, 6826.761063362758, 6831.419329357011, 6358.0, 6527.804165875032, 6529.0, 6529.477641788693, 6538.901916471256, 25563.872180638977, 25597.23208303754, 25702.228933132035, 26864.865675671495, 27044.864775675996, 2231.4867580456425, 2317.5944209763393, 2442.9129037578286, 2488.9377765555823, 2574.918534215634, 14898.627534311729, 15086.265079515886, 15529.990550614288, 15897.92051039749, 16057.0, 1789.3737191982702, 1836.7979522252542, 1854.6012607289363, 1875.41862022772, 1883.2655264446876, 110400.0, 114632.99999999917, 115174.0, 116047.83952160539, 117807.41096294549, 15539.378424862878, 19107.713384299248, 19108.522286942658, 19134.80865191358, 19151.712724309145, 24121.03515859346, 24731.62902556463, 24766.87616561942, 28271.43457130846, 28291.0, 10012.499375031364, 10217.284790064625, 10218.795624087477, 10245.795084098276, 10280.897191028143, 8716.302695784321, 8775.297976161892, 8844.955775221211, 8860.8670869937, 8891.599878005505, 8548.0, 8551.401401901807, 8651.783705407415, 8666.523341216294, 8668.696595619123, 2916.83957382346, 3133.937321253562, 3367.51171080192, 3398.439257522481, 3447.827608619559, 349.25956971220666, 387.6530505197832, 398.1519363755241, 914.5701520285455, 1122.5004872831676, 11196.608118715805, 11889.346085965355, 12044.036477081812, 12143.332116733665, 21576.244831431137, 918.8116436130578, 951.9666811661697, 985.8274801909637, 1041.109851077318, 1056.3767377247461, 9786.217102631772, 10359.948200259101, 11398.658040258806, 11623.59317423886, 11805.70137284898, 608182.0, 611293.0, 612657.0, 760696.0, 762764.0, 85280.0, 124496.37751811364, 133105.0, 133848.0, 135942.0, 1127.8590176227972, 1172.5016867831137, 1182.9053675705923, 1183.7218253710544, 1185.6739396665987, 18089.0, 18342.724859126858, 18346.908265459122, 18435.354762583243, 18609.464201801613, 52936.0, 53632.19551706805, 53792.731036344565, 53882.0, 54631.18053229284, 75461.0, 75935.86096208672, 77539.61230194039, 77750.6112469434, 80441.0, 9711.320207585684, 9745.26910481731, 9927.702168934944, 10057.497125143567, 10069.093781559695, 11757.0, 11814.468348924147, 11864.881351186377, 14307.713845723236, 20495.897520512302, 15690.76463853066, 16149.0, 16156.67686646284, 16245.51263462098, 16414.850960432654, 12980.935095324463, 15699.293531791325, 15906.0, 16050.598735031717, 16087.597810054842, 16086.758698619764, 16133.75799363034, 16437.342506299614, 16764.89849377869, 17015.149242537576, 9905.900940990787, 10043.397396156253, 10048.346857454242, 10140.870372311105, 10179.694609161737, 13967.860321396656, 16160.595985099997, 16211.51365459038, 16602.252898619834, 16603.169841507635], "unit": "ms", "name": "jquery.html", "value": 11018.09515449046}, {"lowerIsBetter": false, "replicates": [1381.4336122189898, 1389.6456403617076, 1394.086873098121, 1678.5635734708976, 1939.3697048459255, 7601.163871974085, 7924.247196516336, 7932.524048557083, 8206.91793082069, 8360.038595561513, 8250.587470626475, 8351.874721879176, 8393.70622028229, 8438.409311348209, 8445.239928406441, 2140.357892632212, 2351.811855051596, 2369.455025344172, 2373.3829204406893, 2381.583222935988, 2196.363054714139, 2202.7797220278003, 2366.9881650591724, 2393.808495320379, 2395.461021270209, 2295.850769699964, 2337.2871274261342, 2341.157183413978, 2341.519988402382, 2349.2952114365708, 2128.372130221588, 2177.771334009922, 2344.8358614896965, 2363.5509253241917, 2374.6200607902824, 2161.967570486444, 2338.0414030247516, 2352.364861487406, 2353.917612883558, 2357.304595144419, 8315.916840831635, 8396.034456037572, 8412.03261624915, 8423.957880210559, 8439.620217090245, 5126.282320475137, 5192.0, 5234.581233501311, 5237.607179461517, 5258.027264955996, 3495.965040349615, 3531.770434921722, 3547.379208638478, 3624.746267761258, 3627.7823330599986, 1065.3767545985609, 1068.6847380022912, 1634.1502418742186, 1650.9174541273007, 1681.9411320603842, 11066.502007409686, 11175.608853690082, 11182.496787644575, 11188.776224475465, 11200.439978001148, 4452.9554704453185, 4454.710443821141, 4534.115847409789, 4546.136234115507, 4555.498895121534, 9012.369134160546, 9019.466690662603, 9025.05236950124, 9035.503047332328, 9049.954750226338, 5176.352955880515, 5197.506236907563, 5206.609504287194, 5207.479252074762, 5208.348956380452, 4797.664163508521, 4805.063012712488, 4843.982763619609, 4845.903081938412, 4848.539388758062, 3449.724022078228, 3518.296340731864, 3543.344481270973, 3562.1985053363305, 3575.785452872784, 1114.1977776001265, 1125.3754166437543, 1133.3539882267028, 1133.6315697398213, 1137.3744440557825, 1081.3619964221148, 1082.437132691012, 1104.3815463340554, 1221.985751826, 1333.120140707148, 6765.898511522331, 7892.960535197287, 7934.166912474223, 7969.083555391204, 7969.641366138538, 496.85591178558536, 509.95665368443355, 513.0585375835309, 515.5875299760177, 519.2107995846293, 5845.970770146122, 5922.822315330547, 5930.22907022093, 6183.752649894044, 6259.3427690091885, 9566.13904748576, 9690.806183876424, 9767.951160244296, 9791.020897910294, 9791.46146961924, 9551.952240238894, 9703.611855525842, 9750.073742994404, 9810.411375317504, 9824.4105353679, 7527.2849079337375, 7695.961520192475, 7778.64996075178, 7806.18035106317, 7850.6859725611475, 7870.606469676608, 7901.841963160819, 7918.802029949067, 7923.801904952422, 7928.722494712888, 8990.640374384951, 9110.498922559058, 9189.264858811413, 9228.169464748205, 9328.300377471582, 9257.0, 9456.385334953206, 9516.238700903772, 9539.856902146335, 9554.235661146953, 6022.698865056642, 6806.6256355900905, 6850.177978642595, 6913.619750913748, 6929.307069293232, 7905.6837726492595, 7946.960265198637, 7966.84066318682, 7995.960525131695, 8060.83878322442, 7388.889166662397, 7515.323620874147, 7560.848783024198, 7679.961600191963, 7717.305442510201, 7303.342699156889, 7369.742059027908, 7418.332350088518, 7445.739399121005, 7521.962390188014, 7503.024606801299, 7539.0, 7540.8491830164185, 7550.395968322631, 7573.242675732383, 6658.234303055017, 6824.146981627297, 6885.655717214019, 6897.655117244018, 6908.620025898624, 6412.519061070531, 6950.20072691647, 6985.511014229159, 7005.6146911918295, 7010.404115650227], "unit": "ms", "name": "mootools.html", "value": 4644.9404398297775}, {"lowerIsBetter": false, "replicates": [319.1749327987153, 324.33025801719447, 325.70198268584244, 330.45639922327774, 335.5754969962999, 6699.966500167492, 6868.62222577758, 6884.5525040872435, 6959.791206263814, 6971.337722916322, 5534.225208470817, 6822.249552549228, 6845.281245469228, 6853.4174595159475, 6863.656817159134, 4971.527704868032, 4984.451710311862, 5080.466551012146, 5112.846614601568, 5125.487451254863, 4331.8267269309345, 4967.875803104933, 5064.772085256154, 5106.208537676647, 5112.8977420451565, 5048.1670524363435, 5076.695398276097, 5088.4911508849, 5090.643654944155, 5101.821436249732, 5048.798048078109, 5062.164742817431, 5075.21334193197, 5076.289319495274, 5083.983203359343, 4341.978290108529, 4347.8695639130565, 4350.1734670412525, 4355.716878402894, 4364.2798938175165, 6423.903641445382, 6669.366410191024, 6679.465642748569, 6682.632455214961, 6684.799456016327, 5946.3459019508255, 5952.0, 5956.285245770492, 5958.0, 5962.0, 7409.925900740977, 7416.629168541552, 7417.666205020787, 7431.145418276913, 7456.813579660497, 4523.117991991563, 4604.769761511911, 4628.745419001953, 4637.397138372024, 4708.952910470885, 7742.806429839243, 7851.175626559186, 7883.408744344197, 7888.802779930547, 7896.447248692594, 4777.976110119427, 4786.042791441726, 4790.137775200497, 4792.688475249098, 4795.664303498722, 4719.811207551728, 4850.95149048512, 4856.1987272099705, 4898.461169271377, 4911.0, 5899.911501327483, 5901.852453688606, 5905.763769449174, 5914.497267732291, 5933.554983376178, 7403.9629801851725, 7410.666520006613, 7417.925820741832, 7431.7770466884995, 7431.85136297271, 1639.4507839873777, 1671.7158083125898, 1698.3800912666788, 1703.1399143432734, 1705.7015022371036, 1060.4114716332356, 1067.770429357692, 1081.7674200047027, 1082.9458527073614, 1087.1737479515625, 6906.896396554056, 6960.37356637905, 6960.617166055814, 6963.1644202696, 6970.965145174242, 7641.656125474367, 7648.541087534766, 7650.4644674872225, 7662.0, 7677.23227677239, 6742.0, 6921.861562768817, 6928.896066559006, 6933.583984960817, 6980.232174460805, 3327.783694059878, 3684.373656478405, 3731.421629647409, 4108.835646574164, 4123.092919557693, 6102.755889764359, 8074.475159114639, 8077.27304542594, 8091.312238459797, 8099.433039687283, 7791.340074592642, 7943.64253608589, 8018.839623207503, 8033.55815430157, 8033.638486268132, 8068.596570171585, 8080.595970201584, 8082.232187942253, 8096.068952070587, 8096.8380632387025, 7420.5176663516695, 7458.627068646654, 7627.321989162376, 7736.303732664087, 7752.0, 6997.47518936092, 7392.0, 7417.92582074194, 7512.173660897188, 7518.586477743776, 8096.51420914747, 8109.310708589836, 8112.1076681566165, 8116.837663246584, 8125.349972002344, 4672.976635116803, 4761.119192949315, 4812.0, 4814.398200224972, 4816.759162041954, 7636.770896873103, 7638.2743639356395, 7665.463417560717, 7668.309852113337, 7669.5398276103615, 6026.668533230714, 7411.62941852916, 7415.592142432218, 7426.74006409773, 7435.591042492715, 7143.392811611071, 7389.519681220703, 7410.6665200065045, 7411.370033546993, 7411.99938008362, 7239.529430586995, 7239.8914016288745, 7244.818879527843, 7251.673674684546, 7255.927440725525, 7209.0628218331285, 7396.186419493959, 7398.3341499265325, 7422.591757453392, 7427.8143046424275, 5544.8355845272945, 7177.425805935617, 7268.418526517971, 7268.927310726825, 7272.0], "unit": "ms", "name": "prototype.html", "value": 5362.031491103671}, {"lowerIsBetter": false, "replicates": [717.7308509309009, 718.3893690363191, 740.8629403560338, 815.6778072661299, 816.0, 15150.924245378772, 15392.307346169422, 15405.306761195745, 15415.69168616627, 15417.920745547815, 14181.220032898187, 14260.073095248828, 14262.71474570508, 14264.643383915381, 14318.212498312589, 740.4224704730319, 748.2779118150984, 748.3825843678959, 748.651876877252, 915.7069737683961, 928.9396189247711, 945.1163162443104, 946.2240962410826, 947.4457442396207, 947.6351604632232, 954.5799848066863, 990.0495524296648, 990.1385794358918, 990.2770977186658, 990.8563258327538, 763.9847203055963, 776.4293244465314, 784.3215618490023, 973.2846357926918, 984.1929617713478, 626.348597458647, 730.9195988441268, 732.2787054751119, 733.2703959560218, 733.6991833348302, 14812.0, 14993.475228367064, 15013.0, 15018.474353397578, 15028.549143525712, 12110.636680899586, 12456.875431245753, 12972.091953563255, 13241.205527668371, 13349.599512014558, 10239.18086553074, 10241.385516869012, 10367.37795732251, 10393.116585090202, 10416.0, 3539.8407071681836, 3628.455731640275, 3707.666310032083, 3738.065483629093, 3757.1734218471893, 83233.16766832375, 83319.0, 83978.0, 83982.0, 84081.57959210165, 9535.666251681296, 9568.665096721581, 9835.409875407355, 9859.0, 9904.504774761233, 21521.246756363453, 21624.78375216228, 21666.13335466595, 21675.024623891964, 21688.34934951954, 7560.924390756132, 7633.0458692663415, 7692.307692307719, 7782.299593036654, 7868.960655196802, 3350.966490335114, 4068.9389659155136, 4113.4858142732155, 4150.91698166035, 4172.5410204877435, 3608.8736894208578, 3639.0356555512813, 3651.1602331463914, 3653.4337177737493, 3656.012876523377, 633.0851918977125, 638.1576319258534, 640.3372509452694, 644.8516841126567, 677.3734295776486, 489.6352217597841, 513.5891286970483, 521.4955499046403, 548.1585765849402, 647.970841312142, 8694.91305086941, 8714.172153645393, 8833.911660883308, 8839.69061082859, 8996.235319997742, 527.9260903473516, 533.6104643610187, 601.6420229963165, 606.6087373643975, 618.8669436071266, 3953.802309884494, 4134.545200027995, 4266.104118135227, 4373.6282415994365, 4516.299973504112, 93829.0, 94920.0, 95298.52350738202, 102124.0, 103265.45101823479, 81728.0, 83118.58440707758, 85623.5718821402, 88417.55791221131, 90077.7480562978, 59661.0, 78252.60873695595, 78490.0, 80117.0, 81114.18885811066, 9070.455772653662, 9108.726738197865, 9125.406848554823, 9225.12361325673, 9238.568021956607, 50007.0, 50224.0, 50433.74783126061, 50611.24083138682, 51086.0, 62900.37099629128, 64283.67858160679, 65630.67184664046, 67773.9833902482, 70979.29020709933, 11010.559577617127, 11115.555377785122, 11245.38150401703, 11271.661850144508, 11506.884931150582, 12048.277103373826, 12237.0, 12555.35037032623, 12569.685757856127, 12866.549670761478, 11260.887391125983, 11295.830562541403, 11487.425628718698, 11809.645710628694, 11846.585369512026, 11442.0, 11483.770324593628, 11791.88208117908, 11845.23006004607, 12490.000799936164, 8811.396837301667, 10397.948010260203, 10848.728781780519, 11555.88444115548, 11672.533098675958, 8071.354291656771, 9620.807583848424, 9731.075547822946, 9743.658971935949, 9844.753881153028, 9761.658341957997, 9990.750231244278, 10003.899961000589, 10017.04497173321, 10102.09081182697], "unit": "ms", "name": "yui.html", "value": 7024.138207670559}], "name": "dromaeo_css", "value": 7811.926522584012}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 108.0, 109.0, 107.0, 109.0, 109.0, 123.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 141.0, 155.0, 116.0, 141.0, 140.0, 118.0, 159.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.6}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 183.0, 180.0, 185.0, 185.0, 183.0, 187.0, 260.0, 206.0], "unit": "ms", "name": "audio-dft", "value": 193.5}, {"lowerIsBetter": true, "replicates": [61.0, 70.0, 76.0, 92.0, 81.0, 81.0, 67.0, 72.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 72.6}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 120.0, 75.0, 75.0, 74.0, 114.0, 74.0, 76.0, 116.0], "unit": "ms", "name": "audio-oscillator", "value": 88.5}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 91.0, 132.0, 87.0, 89.0, 87.0, 88.0, 87.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 92.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 83.0, 85.0, 85.0, 86.0, 87.0, 86.0, 84.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 56.0, 55.0, 53.0, 55.0, 55.0, 65.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 81.0, 82.0, 85.0, 81.0, 81.0, 81.0, 81.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 128.0, 122.0, 121.0, 123.0, 119.0, 125.0, 118.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [133.0, 123.0, 132.0, 135.0, 133.0, 122.0, 133.0, 132.0, 133.0, 121.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 129.7}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 64.0, 62.0, 61.0, 63.0, 65.0, 57.0, 55.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.2}], "name": "kraken", "value": 1389.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.49262536873155], "unit": "score", "name": "Richards", "value": 239.34755999999993}, {"lowerIsBetter": false, "replicates": [159.6678907871627], "unit": "score", "name": "DeltaBlue", "value": 414.09703399999995}, {"lowerIsBetter": false, "replicates": [285.06271379703537], "unit": "score", "name": "Encrypt", "value": 933.7629479999997}, {"lowerIsBetter": false, "replicates": [4780.952380952381], "unit": "score", "name": "Decrypt", "value": 55.67530876494026}, {"lowerIsBetter": false, "replicates": [1714.041095890411], "unit": "score", "name": "RayTrace", "value": 431.721854145854}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "Earley", "value": 701.7855390000002}, {"lowerIsBetter": false, "replicates": [12530.864197530864], "unit": "score", "name": "Boyer", "value": 53.185717241379315}, {"lowerIsBetter": false, "replicates": [28138.88888888889], "unit": "score", "name": "RegExp", "value": 32.37459032576504}, {"lowerIsBetter": false, "replicates": [717.8750897343862], "unit": "score", "name": "Splay", "value": 113.51696300000005}, {"lowerIsBetter": false, "replicates": [4529.411764705882], "unit": "score", "name": "NavierStokes", "value": 327.63636363636374}], "name": "v8_7", "value": 20032.618250255124}]} 15:36:26 INFO - RETURN: dromaeo_css: 7811.93 15:36:26 INFO - RETURN: kraken: 1389.40 15:36:26 INFO - RETURN: v8_7: 20032.62 15:36:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20032.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1389.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7811.93"}}} 15:36:26 INFO - Return code: 0 15:36:26 INFO - # TBPL SUCCESS # 15:36:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:26 INFO - 2015-11-19 15:36:26.947 screenresolution[2244:70304] starting screenresolution argv=screenresolution get 15:36:26 INFO - 2015-11-19 15:36:26.950 screenresolution[2244:70304] Display 0: 1600x1200x32@60 15:36:26 INFO - 2015-11-19 15:36:26.956 screenresolution[2245:70307] starting screenresolution argv=screenresolution list 15:36:26 INFO - Available Modes on Display 0 15:36:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:27 INFO - Intel Iris: 15:36:27 INFO - Chipset Model: Intel Iris 15:36:27 INFO - Type: GPU 15:36:27 INFO - Bus: Built-In 15:36:27 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:27 INFO - Vendor: Intel (0x8086) 15:36:27 INFO - Device ID: 0x0a2e 15:36:27 INFO - Revision ID: 0x0009 15:36:27 INFO - Displays: 15:36:27 INFO - Display: 15:36:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:27 INFO - Display Serial Number: 1600x1200 60 15:36:27 INFO - Main Display: Yes 15:36:27 INFO - Mirror: Off 15:36:27 INFO - Online: Yes 15:36:27 INFO - Rotation: Supported 15:36:27 INFO - Return code: 0 15:36:27 INFO - Running post-action listener: _resource_record_post_action 15:36:27 INFO - Running post-run listener: _resource_record_post_run 15:36:28 INFO - Total resource usage - Wall time: 1239s; CPU: 52.0%; Read bytes: 45056; Write bytes: 689789440; Read time: 2; Write time: 2034 15:36:28 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334797312; Write bytes: 337606656; Read time: 26046; Write time: 631 15:36:28 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 20480; Write bytes: 341758464; Read time: 1; Write time: 1372 15:36:28 INFO - Running post-run listener: _upload_blobber_files 15:36:28 INFO - Blob upload gear active. 15:36:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:36:28 INFO - Copying logs to upload dir... 15:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1291.761825 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2015-11-19 15:36:28.314603) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:36:28.317734) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009433 build_url: 'https://queue.taskcluster.net/v1/task/fqhrCt7FTYyuGGNXCsWJ_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:36:28.344479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:36:28.344813) ========= 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.QBQQM8vwJp/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.OHCR0oMkxm/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005160 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:36:28.494783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 15:36:28.495185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 15:36:28.495820) ========= ========= Total master_lag: 0.52 =========