builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0078 starttime: 1446584361.86 results: success (0) buildid: 20151103112132 builduid: 6c4bba5cff354979aba7d7c4eb5bb2d5 revision: 508d22157bcaa54efffd74be9dc183abd6919799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.865524) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.866104) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.866438) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006145 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.908404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.908769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.999005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:21.999335) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005567 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.071102) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.071498) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.072157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.072530) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False --2015-11-03 12:59:22-- 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% 13.2M=0.001s 2015-11-03 12:59:22 (13.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.312427 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.426703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.427034) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.020554 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.504208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:22.504616) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 508d22157bcaa54efffd74be9dc183abd6919799 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 508d22157bcaa54efffd74be9dc183abd6919799 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False 2015-11-03 12:59:22,610 truncating revision to first 12 chars 2015-11-03 12:59:22,610 Setting DEBUG logging. 2015-11-03 12:59:22,610 attempt 1/10 2015-11-03 12:59:22,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/508d22157bca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-03 12:59:23,005 unpacking tar archive at: mozilla-inbound-508d22157bca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647673 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:23.196199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:23.196551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:23.216839) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:23.217156) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 12:59:23.217946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-03 12:59:23.218265) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False 12:59:23 INFO - MultiFileLogger online at 20151103 12:59:23 in /builds/slave/test 12:59:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:59:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:23 INFO - {'append_to_log': False, 12:59:23 INFO - 'base_work_dir': '/builds/slave/test', 12:59:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:59:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:23 INFO - 'branch': 'Mozilla-Inbound', 12:59:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:23 INFO - 'config_files': ('talos/mac_config.py',), 12:59:23 INFO - 'default_actions': ('clobber', 12:59:23 INFO - 'read-buildbot-config', 12:59:23 INFO - 'download-and-extract', 12:59:23 INFO - 'populate-webroot', 12:59:23 INFO - 'create-virtualenv', 12:59:23 INFO - 'install', 12:59:23 INFO - 'run-tests'), 12:59:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:23 INFO - 'download_minidump_stackwalk': True, 12:59:23 INFO - 'download_symbols': 'ondemand', 12:59:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:23 INFO - 'installer_path': 'installer.exe', 12:59:23 INFO - 'log_level': 'info', 12:59:23 INFO - 'log_name': 'talos', 12:59:23 INFO - 'log_to_console': True, 12:59:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:59:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:59:23 INFO - 'opt_config_files': (), 12:59:23 INFO - 'pip_index': False, 12:59:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:59:23 INFO - 'cmd': ('bash', 12:59:23 INFO - '-c', 12:59:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:59:23 INFO - 'enabled': True, 12:59:23 INFO - 'halt_on_failure': False, 12:59:23 INFO - 'name': 'check_screen_resolution'},), 12:59:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:59:23 INFO - 'cmd': ('bash', 12:59:23 INFO - '-c', 12:59:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:59:23 INFO - 'enabled': True, 12:59:23 INFO - 'halt_on_failure': False, 12:59:23 INFO - 'name': 'check_screen_resolution'},), 12:59:23 INFO - 'run_cmd_checks_enabled': True, 12:59:23 INFO - 'sps_profile': False, 12:59:23 INFO - 'sps_profile_interval': 0, 12:59:23 INFO - 'suite': 'dromaeojs', 12:59:23 INFO - 'system_bits': '64', 12:59:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:23 INFO - 'title': 't-yosemite-r5-0078', 12:59:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:23 INFO - 'use_talos_json': True, 12:59:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:23 INFO - 'work_dir': 'build'} 12:59:23 INFO - ##### 12:59:23 INFO - ##### Running clobber step. 12:59:23 INFO - ##### 12:59:23 INFO - Running pre-action listener: _resource_record_pre_action 12:59:23 INFO - Running main action method: clobber 12:59:23 INFO - rmtree: /builds/slave/test/build 12:59:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:24 INFO - Running post-action listener: _resource_record_post_action 12:59:24 INFO - ##### 12:59:24 INFO - ##### Running read-buildbot-config step. 12:59:24 INFO - ##### 12:59:24 INFO - Running pre-action listener: _resource_record_pre_action 12:59:24 INFO - Running main action method: read_buildbot_config 12:59:24 INFO - Using buildbot properties: 12:59:24 INFO - { 12:59:24 INFO - "properties": { 12:59:24 INFO - "buildnumber": 3228, 12:59:24 INFO - "product": "firefox", 12:59:24 INFO - "script_repo_revision": "production", 12:59:24 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 12:59:24 INFO - "repository": "", 12:59:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 12:59:24 INFO - "buildid": "20151103112132", 12:59:24 INFO - "slavename": "t-yosemite-r5-0078", 12:59:24 INFO - "pgo_build": "False", 12:59:24 INFO - "basedir": "/builds/slave/test", 12:59:24 INFO - "project": "", 12:59:24 INFO - "platform": "yosemite", 12:59:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:59:24 INFO - "slavebuilddir": "test", 12:59:24 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 12:59:24 INFO - "branch": "mozilla-inbound", 12:59:24 INFO - "repo_path": "integration/mozilla-inbound", 12:59:24 INFO - "stage_platform": "macosx64", 12:59:24 INFO - "builduid": "6c4bba5cff354979aba7d7c4eb5bb2d5", 12:59:24 INFO - "revision": "508d22157bcaa54efffd74be9dc183abd6919799" 12:59:24 INFO - }, 12:59:24 INFO - "sourcestamp": { 12:59:24 INFO - "repository": "", 12:59:24 INFO - "hasPatch": false, 12:59:24 INFO - "project": "", 12:59:24 INFO - "branch": "mozilla-inbound-macosx64-talos", 12:59:24 INFO - "changes": [ 12:59:24 INFO - { 12:59:24 INFO - "category": null, 12:59:24 INFO - "files": [ 12:59:24 INFO - { 12:59:24 INFO - "url": null, 12:59:24 INFO - "name": "https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:59:24 INFO - } 12:59:24 INFO - ], 12:59:24 INFO - "repository": "", 12:59:24 INFO - "rev": "508d22157bcaa54efffd74be9dc183abd6919799", 12:59:24 INFO - "who": "bkelly@mozilla.com", 12:59:24 INFO - "when": 1446584309, 12:59:24 INFO - "number": 6616598, 12:59:24 INFO - "comments": "Bug 1220007 P2 Make InterceptedChannel's collect logs locally and only flush to nsIChannel on main thread r=bz", 12:59:24 INFO - "project": "", 12:59:24 INFO - "at": "Tue 03 Nov 2015 12:58:29", 12:59:24 INFO - "branch": "mozilla-inbound-macosx64-talos", 12:59:24 INFO - "revlink": "", 12:59:24 INFO - "properties": [ 12:59:24 INFO - [ 12:59:24 INFO - "buildid", 12:59:24 INFO - "20151103112132", 12:59:24 INFO - "Change" 12:59:24 INFO - ], 12:59:24 INFO - [ 12:59:24 INFO - "builduid", 12:59:24 INFO - "6c4bba5cff354979aba7d7c4eb5bb2d5", 12:59:24 INFO - "Change" 12:59:24 INFO - ], 12:59:24 INFO - [ 12:59:24 INFO - "pgo_build", 12:59:24 INFO - "False", 12:59:24 INFO - "Change" 12:59:24 INFO - ] 12:59:24 INFO - ], 12:59:24 INFO - "revision": "508d22157bcaa54efffd74be9dc183abd6919799" 12:59:24 INFO - } 12:59:24 INFO - ], 12:59:24 INFO - "revision": "508d22157bcaa54efffd74be9dc183abd6919799" 12:59:24 INFO - } 12:59:24 INFO - } 12:59:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:59:24 INFO - Running post-action listener: _resource_record_post_action 12:59:24 INFO - ##### 12:59:24 INFO - ##### Running download-and-extract step. 12:59:24 INFO - ##### 12:59:24 INFO - Running pre-action listener: _resource_record_pre_action 12:59:24 INFO - Running main action method: download_and_extract 12:59:24 INFO - mkdir: /builds/slave/test/build/tests 12:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:24 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/test_packages.json 12:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/test_packages.json 12:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:59:25 INFO - Downloaded 1149 bytes. 12:59:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:59:25 INFO - Using the following test package requirements: 12:59:25 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:59:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:59:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'jsshell-mac.zip'], 12:59:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:59:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:59:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:59:25 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:59:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:59:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:59:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:59:25 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:59:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:59: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')]} 12:59:25 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:27 INFO - Downloaded 17456913 bytes. 12:59:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:59:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:59:31 INFO - Return code: 0 12:59:31 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 12:59:31 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')]} 12:59:31 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:42 INFO - Downloaded 17456913 bytes. 12:59:42 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 12:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:59:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:59:47 INFO - Return code: 0 12:59:47 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')]} 12:59:47 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:49 INFO - Downloaded 11131307 bytes. 12:59:49 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 12:59:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:59:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:59:49 INFO - Return code: 0 12:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:49 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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 12:59:53 INFO - Downloaded 108614784 bytes. 12:59:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:59:53 INFO - mkdir: /builds/slave/test/properties 12:59:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:59:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:59:53 INFO - Contents: 12:59:53 INFO - build_url:https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:59:53 INFO - Running post-action listener: _resource_record_post_action 12:59:53 INFO - Running post-action listener: set_extra_try_arguments 12:59:53 INFO - ##### 12:59:53 INFO - ##### Running populate-webroot step. 12:59:53 INFO - ##### 12:59:53 INFO - Running pre-action listener: _resource_record_pre_action 12:59:53 INFO - Running main action method: populate_webroot 12:59:53 INFO - Guessing talos json url... 12:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:53 INFO - https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 12:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 12:59:54 INFO - Downloaded 111 bytes. 12:59:54 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:59:54 INFO - Contents: 12:59:54 INFO - 20151103112132 12:59:54 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/508d22157bcaa54efffd74be9dc183abd6919799 12:59:54 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')]} 12:59:54 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/508d22157b/testing/talos/talos.json 12:59:54 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/508d22157b/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/508d22157b/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:59:54 INFO - Downloaded 4264 bytes. 12:59:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:59:54 INFO - '../fennec_ids.txt'], 12:59:54 INFO - 'tests': ['tcheck2']}, 12:59:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:54 INFO - '--tppagecycles', 12:59:54 INFO - '7'], 12:59:54 INFO - 'tests': ['tsvgm']}}, 12:59:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:59:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:59:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:59:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'tests': ['damp', 'tps']}, 12:59:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['damp', 'tps']}, 12:59:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:59:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:54 INFO - 'other': {'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'other_l64': {'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'other_nol64': {'tests': ['a11yr', 12:59:54 INFO - 'ts_paint', 12:59:54 INFO - 'tpaint', 12:59:54 INFO - 'sessionrestore', 12:59:54 INFO - 'sessionrestore_no_auto_restore']}, 12:59:54 INFO - 'svgr': {'tests': ['tsvgx', 12:59:54 INFO - 'tsvgr_opacity', 12:59:54 INFO - 'tart', 12:59:54 INFO - 'tscrollx', 12:59:54 INFO - 'cart']}, 12:59:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['tsvgx', 12:59:54 INFO - 'tsvgr_opacity', 12:59:54 INFO - 'tart', 12:59:54 INFO - 'tscrollx', 12:59:54 INFO - 'cart']}, 12:59:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'tests': ['tp5o']}, 12:59:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'talos_options': ['--e10s'], 12:59:54 INFO - 'tests': ['tp5o']}, 12:59:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'talos_options': ['--xperf_path', 12:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:54 INFO - 'tests': ['tp5n']}, 12:59:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:54 INFO - 'talos_options': ['--e10s', 12:59:54 INFO - '--xperf_path', 12:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:59:54 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:59:54 INFO - 'tests': ['tp5n']}}, 12:59:54 INFO - 'talos.zip': {'path': '', 12:59:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:54 INFO - Running post-action listener: _resource_record_post_action 12:59:54 INFO - ##### 12:59:54 INFO - ##### Running create-virtualenv step. 12:59:54 INFO - ##### 12:59:54 INFO - Running pre-action listener: _resource_record_pre_action 12:59:54 INFO - Running main action method: create_virtualenv 12:59:54 INFO - Creating virtualenv /builds/slave/test/build/venv 12:59:54 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 12:59:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:59:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:55 INFO - Using real prefix '/tools/python27' 12:59:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:59:55 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:59 INFO - Installing pip.................done. 12:59:59 INFO - Return code: 0 12:59:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 12:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:59 INFO - 'HOME': '/Users/cltbld', 12:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:59 INFO - 'LOGNAME': 'cltbld', 12:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:59 INFO - 'MOZ_NO_REMOTE': '1', 12:59:59 INFO - 'NO_EM_RESTART': '1', 12:59:59 INFO - 'PAGER': '/bin/cat', 12:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:59 INFO - 'PWD': '/builds/slave/test', 12:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:59 INFO - 'SHELL': '/bin/bash', 12:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 12:59:59 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 12:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:59 INFO - 'USER': 'cltbld', 12:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:59 INFO - 'XPC_FLAGS': '0x0', 12:59:59 INFO - 'XPC_SERVICE_NAME': '0', 12:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:59 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 12:59:59 INFO - Cleaning up... 12:59:59 INFO - Return code: 0 12:59:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 12:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:59 INFO - 'HOME': '/Users/cltbld', 12:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:59 INFO - 'LOGNAME': 'cltbld', 12:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:59 INFO - 'MOZ_NO_REMOTE': '1', 12:59:59 INFO - 'NO_EM_RESTART': '1', 12:59:59 INFO - 'PAGER': '/bin/cat', 12:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:59 INFO - 'PWD': '/builds/slave/test', 12:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:59 INFO - 'SHELL': '/bin/bash', 12:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 12:59:59 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 12:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:59 INFO - 'USER': 'cltbld', 12:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:59 INFO - 'XPC_FLAGS': '0x0', 12:59:59 INFO - 'XPC_SERVICE_NAME': '0', 12:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:00 INFO - Downloading/unpacking psutil>=0.7.1 13:00:00 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 13:00:00 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 13:00:00 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 13:00:00 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 13:00:00 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 13:00:00 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 13:00:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:02 INFO - Installing collected packages: psutil 13:00:02 INFO - Running setup.py install for psutil 13:00:03 INFO - building 'psutil._psutil_osx' extension 13:00:03 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 13:00:03 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 13:00:03 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 13:00:03 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 13:00:03 INFO - building 'psutil._psutil_posix' extension 13:00:03 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 13:00:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:00:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:00:03 INFO - ^ 13:00:03 INFO - 1 warning generated. 13:00:03 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 13:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:03 INFO - Successfully installed psutil 13:00:03 INFO - Cleaning up... 13:00:04 INFO - Return code: 0 13:00:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:04 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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:04 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 13:00:04 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 13:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:04 INFO - 'HOME': '/Users/cltbld', 13:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:04 INFO - 'LOGNAME': 'cltbld', 13:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:04 INFO - 'MOZ_NO_REMOTE': '1', 13:00:04 INFO - 'NO_EM_RESTART': '1', 13:00:04 INFO - 'PAGER': '/bin/cat', 13:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:04 INFO - 'PWD': '/builds/slave/test', 13:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:04 INFO - 'SHELL': '/bin/bash', 13:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:00:04 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:04 INFO - 'USER': 'cltbld', 13:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:04 INFO - 'XPC_FLAGS': '0x0', 13:00:04 INFO - 'XPC_SERVICE_NAME': '0', 13:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:00:06 INFO - Installing collected packages: mozsystemmonitor 13:00:06 INFO - Running setup.py install for mozsystemmonitor 13:00:07 INFO - Successfully installed mozsystemmonitor 13:00:07 INFO - Cleaning up... 13:00:07 INFO - Return code: 0 13:00:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:07 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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:07 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 13:00:07 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 13:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:07 INFO - 'HOME': '/Users/cltbld', 13:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:07 INFO - 'LOGNAME': 'cltbld', 13:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:07 INFO - 'MOZ_NO_REMOTE': '1', 13:00:07 INFO - 'NO_EM_RESTART': '1', 13:00:07 INFO - 'PAGER': '/bin/cat', 13:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:07 INFO - 'PWD': '/builds/slave/test', 13:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:07 INFO - 'SHELL': '/bin/bash', 13:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:00:07 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:07 INFO - 'USER': 'cltbld', 13:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:07 INFO - 'XPC_FLAGS': '0x0', 13:00:07 INFO - 'XPC_SERVICE_NAME': '0', 13:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:07 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:07 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 13:00:07 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 13:00:07 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 13:00:07 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 13:00:07 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 13:00:07 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 13:00:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:12 INFO - Downloading docopt-0.6.1.tar.gz 13:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:12 INFO - Running setup.py install for blobuploader 13:00:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:12 INFO - Running setup.py install for requests 13:00:13 INFO - Running setup.py install for docopt 13:00:13 INFO - Successfully installed blobuploader requests docopt 13:00:13 INFO - Cleaning up... 13:00:13 INFO - Return code: 0 13:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:13 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 13:00:13 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 13:00:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:00:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:13 INFO - 'HOME': '/Users/cltbld', 13:00:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:13 INFO - 'LOGNAME': 'cltbld', 13:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:13 INFO - 'MOZ_NO_REMOTE': '1', 13:00:13 INFO - 'NO_EM_RESTART': '1', 13:00:13 INFO - 'PAGER': '/bin/cat', 13:00:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:13 INFO - 'PWD': '/builds/slave/test', 13:00:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:13 INFO - 'SHELL': '/bin/bash', 13:00:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:00:13 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:00:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:13 INFO - 'USER': 'cltbld', 13:00:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:13 INFO - 'XPC_FLAGS': '0x0', 13:00:13 INFO - 'XPC_SERVICE_NAME': '0', 13:00:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:13 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-usb4_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:13 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-TggO4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:13 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-9A8T4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-jSWne9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-NhQJpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-L9u8JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-iKPMfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-JTLu6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-tiJvFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-d1l9Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:14 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-vtDi1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-blD_17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-G4fKPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-6H2DH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-QtABKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-IT2cjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:15 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-1MLL4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:15 INFO - Running setup.py install for manifestparser 13:00:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:16 INFO - Running setup.py install for mozcrash 13:00:16 INFO - Running setup.py install for mozdebug 13:00:16 INFO - Running setup.py install for mozdevice 13:00:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:16 INFO - Running setup.py install for mozfile 13:00:16 INFO - Running setup.py install for mozhttpd 13:00:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Running setup.py install for mozinfo 13:00:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Running setup.py install for mozInstall 13:00:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Running setup.py install for mozleak 13:00:17 INFO - Running setup.py install for mozlog 13:00:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Running setup.py install for moznetwork 13:00:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:17 INFO - Running setup.py install for mozprocess 13:00:18 INFO - Running setup.py install for mozprofile 13:00:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:18 INFO - Running setup.py install for mozrunner 13:00:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:18 INFO - Running setup.py install for mozscreenshot 13:00:18 INFO - Running setup.py install for moztest 13:00:18 INFO - Running setup.py install for mozversion 13:00:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:19 INFO - Cleaning up... 13:00:19 INFO - Return code: 0 13:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:19 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')]} 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 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')]} 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:19 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 13:00:19 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 13:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:19 INFO - 'HOME': '/Users/cltbld', 13:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:19 INFO - 'LOGNAME': 'cltbld', 13:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:19 INFO - 'MOZ_NO_REMOTE': '1', 13:00:19 INFO - 'NO_EM_RESTART': '1', 13:00:19 INFO - 'PAGER': '/bin/cat', 13:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:19 INFO - 'PWD': '/builds/slave/test', 13:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:19 INFO - 'SHELL': '/bin/bash', 13:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:00:19 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:19 INFO - 'USER': 'cltbld', 13:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:19 INFO - 'XPC_FLAGS': '0x0', 13:00:19 INFO - 'XPC_SERVICE_NAME': '0', 13:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:19 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-nWr2wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:19 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)) 13:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:19 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-1RV0wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:19 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)) 13:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:19 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-ZnzIU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:19 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)) 13:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:19 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-HmKzd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-muCohN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-S9jErB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-PL1AFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-3HJ7j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-AhSEUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-k92b_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-H8SVQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:20 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)) 13:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:20 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-0lTu30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:21 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)) 13:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:21 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-Awr3jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:21 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)) 13:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:21 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-snHcJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:21 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)) 13:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:21 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-zBuRAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:21 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)) 13:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:21 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-nqDm7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:21 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)) 13:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:21 INFO - Running setup.py (path:/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/pip-5Itmny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:21 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)) 13:00:21 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)) 13:00:21 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)) 13:00:21 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)) 13:00:21 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)) 13:00:21 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)) 13:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:21 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 13:00:21 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 13:00:21 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 13:00:21 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 13:00:21 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 13:00:21 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 13:00:24 INFO - Downloading blessings-1.5.1.tar.gz 13:00:24 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 13:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:24 INFO - Installing collected packages: blessings 13:00:24 INFO - Running setup.py install for blessings 13:00:24 INFO - Successfully installed blessings 13:00:24 INFO - Cleaning up... 13:00:24 INFO - Return code: 0 13:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:25 INFO - Reading from file tmpfile_stdout 13:00:25 INFO - Current package versions: 13:00:25 INFO - blessings == 1.5.1 13:00:25 INFO - blobuploader == 1.2.4 13:00:25 INFO - docopt == 0.6.1 13:00:25 INFO - manifestparser == 1.1 13:00:25 INFO - mozInstall == 1.12 13:00:25 INFO - mozcrash == 0.16 13:00:25 INFO - mozdebug == 0.1 13:00:25 INFO - mozdevice == 0.47 13:00:25 INFO - mozfile == 1.2 13:00:25 INFO - mozhttpd == 0.7 13:00:25 INFO - mozinfo == 0.9 13:00:25 INFO - mozleak == 0.1 13:00:25 INFO - mozlog == 3.0 13:00:25 INFO - moznetwork == 0.27 13:00:25 INFO - mozprocess == 0.22 13:00:25 INFO - mozprofile == 0.27 13:00:25 INFO - mozrunner == 6.11 13:00:25 INFO - mozscreenshot == 0.1 13:00:25 INFO - mozsystemmonitor == 0.0 13:00:25 INFO - moztest == 0.7 13:00:25 INFO - mozversion == 1.4 13:00:25 INFO - psutil == 3.1.1 13:00:25 INFO - requests == 1.2.3 13:00:25 INFO - wsgiref == 0.1.2 13:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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', '-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 0x102525a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b51f50720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/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.HKYCqRn3uG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:25 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 13:00:25 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 13:00:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:00:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:25 INFO - 'HOME': '/Users/cltbld', 13:00:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:25 INFO - 'LOGNAME': 'cltbld', 13:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:25 INFO - 'MOZ_NO_REMOTE': '1', 13:00:25 INFO - 'NO_EM_RESTART': '1', 13:00:25 INFO - 'PAGER': '/bin/cat', 13:00:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:25 INFO - 'PWD': '/builds/slave/test', 13:00:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:25 INFO - 'SHELL': '/bin/bash', 13:00:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:00:25 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:00:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:25 INFO - 'USER': 'cltbld', 13:00:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:25 INFO - 'XPC_FLAGS': '0x0', 13:00:25 INFO - 'XPC_SERVICE_NAME': '0', 13:00:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 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)) 13:00:25 INFO - Cleaning up... 13:00:25 INFO - Return code: 0 13:00:25 INFO - Running post-action listener: _resource_record_post_action 13:00:25 INFO - Running post-action listener: _start_resource_monitoring 13:00:25 INFO - Starting resource monitoring. 13:00:25 INFO - ##### 13:00:25 INFO - ##### Running install step. 13:00:25 INFO - ##### 13:00:25 INFO - Running pre-action listener: _resource_record_pre_action 13:00:25 INFO - Running main action method: install 13:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:25 INFO - Reading from file tmpfile_stdout 13:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:25 INFO - Reading from file tmpfile_stdout 13:00:25 INFO - Output received: 13:00:25 INFO - Usage: mozinstall [options] installer 13:00:25 INFO - Options: 13:00:25 INFO - -h, --help show this help message and exit 13:00:25 INFO - -d DEST, --destination=DEST 13:00:25 INFO - Directory to install application into. [default: 13:00:25 INFO - "/builds/slave/test"] 13:00:25 INFO - --app=APP Application being installed. [default: firefox] 13:00:25 INFO - mkdir: /builds/slave/test/build/application 13:00:25 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'] 13:00:25 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 13:01:05 INFO - Reading from file tmpfile_stdout 13:01:05 INFO - Output received: 13:01:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:01:05 INFO - Running post-action listener: _resource_record_post_action 13:01:05 INFO - ##### 13:01:05 INFO - ##### Running run-tests step. 13:01:05 INFO - ##### 13:01:05 INFO - Running pre-action listener: _resource_record_pre_action 13:01:05 INFO - Running main action method: run_tests 13:01:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:01:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:01:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:01:05 INFO - 2015-11-03 13:01:05.823 screenresolution[2555:25390] starting screenresolution argv=screenresolution get 13:01:05 INFO - 2015-11-03 13:01:05.826 screenresolution[2555:25390] Display 0: 1600x1200x32@60 13:01:05 INFO - 2015-11-03 13:01:05.833 screenresolution[2556:25392] starting screenresolution argv=screenresolution list 13:01:05 INFO - Available Modes on Display 0 13:01:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:01:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:01:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:01:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:01:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:01:06 INFO - Intel HD Graphics 3000: 13:01:06 INFO - Chipset Model: Intel HD Graphics 3000 13:01:06 INFO - Type: GPU 13:01:06 INFO - Bus: Built-In 13:01:06 INFO - VRAM (Total): 512 MB 13:01:06 INFO - VRAM (Dynamic, Max): 10 13:01:06 INFO - Vendor: Intel (0x8086) 13:01:06 INFO - Device ID: 0x0116 13:01:06 INFO - Revision ID: 0x0009 13:01:06 INFO - Displays: 13:01:06 INFO - Display: 13:01:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:01:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:01:06 INFO - Display Serial Number: 1600x1200 60 13:01:06 INFO - Main Display: Yes 13:01:06 INFO - Mirror: Off 13:01:06 INFO - Online: Yes 13:01:06 INFO - Rotation: Supported 13:01:06 INFO - Return code: 0 13:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:06 INFO - Python 2.7.3 13:01:06 INFO - Return code: 0 13:01:06 INFO - grabbing minidump binary from tooltool 13:01:06 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')]} 13:01:06 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 0x1024da9f0>, '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 0x102239cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024a4990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:06 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 13:01:06 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 13:01:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:06 INFO - Return code: 0 13:01:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:01:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:01:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0078', '--webServer', 'localhost'] in /builds/slave/test/build 13:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0078 --webServer localhost 13:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k3a4305uPp/Render', 13:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:06 INFO - 'HOME': '/Users/cltbld', 13:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:06 INFO - 'LOGNAME': 'cltbld', 13:01:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:06 INFO - 'MOZ_NO_REMOTE': '1', 13:01:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:06 INFO - 'NO_EM_RESTART': '1', 13:01:06 INFO - 'PAGER': '/bin/cat', 13:01:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:06 INFO - 'PWD': '/builds/slave/test', 13:01:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:06 INFO - 'SHELL': '/bin/bash', 13:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HKYCqRn3uG/Listeners', 13:01:06 INFO - 'TMPDIR': '/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/', 13:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:06 INFO - 'USER': 'cltbld', 13:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:06 INFO - 'XPC_FLAGS': '0x0', 13:01:06 INFO - 'XPC_SERVICE_NAME': '0', 13:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:01:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0078', '--webServer', 'localhost'] with output_timeout 3600 13:01:06 INFO - mozversion INFO | application_buildid: 20151103112132 13:01:06 INFO - mozversion INFO | application_changeset: 508d22157bcaa54efffd74be9dc183abd6919799 13:01:06 INFO - mozversion INFO | application_display_name: Nightly 13:01:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:06 INFO - mozversion INFO | application_name: Firefox 13:01:06 INFO - mozversion INFO | application_remotingname: firefox 13:01:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:01:06 INFO - mozversion INFO | application_vendor: Mozilla 13:01:06 INFO - mozversion INFO | application_version: 45.0a1 13:01:06 INFO - mozversion INFO | platform_buildid: 20151103112132 13:01:06 INFO - mozversion INFO | platform_changeset: 508d22157bcaa54efffd74be9dc183abd6919799 13:01:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:01:06 INFO - mozversion INFO | platform_version: 45.0a1 13:01:06 INFO - 2015-11-03 13:01:06,483 DEBUG : using testdate: 1446584466 13:01:06 INFO - 2015-11-03 13:01:06,483 DEBUG : actual date: 1446584466 13:01:06 INFO - 2015-11-03 13:01:06,533 INFO : starting webserver on 'localhost:54517' 13:01:06 INFO - 2015-11-03 13:01:06,534 INFO : Starting test suite t-yosemite-r5-0078 13:01:06 INFO - 2015-11-03 13:01:06,534 INFO : Starting test dromaeo_css 13:01:06 INFO - 2015-11-03 13:01:06,534 DEBUG : operating with platform_type : mac_ 13:01:06 INFO - 2015-11-03 13:01:06,535 INFO : Initialising browser for dromaeo_css test... 13:01:06 INFO - 2015-11-03 13:01:06,550 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpm03JSH/profile http://localhost:54517/getInfo.html 13:01:08 INFO - 2015-11-03 13:01:08,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:01:08 INFO - 2015-11-03 13:01:08,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:01:08 INFO - 2015-11-03 13:01:08,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:01:08 INFO - 2015-11-03 13:01:08,970 DEBUG : BROWSER_OUTPUT: __metrics 13:01:08 INFO - 2015-11-03 13:01:08,980 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:01:09 INFO - 2015-11-03 13:01:09,736 INFO : Browser initialized. 13:01:09 INFO - 2015-11-03 13:01:09,736 INFO : Running cycle 1/1 for dromaeo_css test... 13:01:09 INFO - 2015-11-03 13:01:09,737 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpm03JSH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:01:21 INFO - 2015-11-03 13:01:21,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 220368896 13:01:21 INFO - 2015-11-03 13:01:21,738 DEBUG : BROWSER_OUTPUT: 13:02:12 INFO - 2015-11-03 13:02:12,713 DEBUG : BROWSER_OUTPUT: 1446584532708 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] 13:04:23 INFO - 2015-11-03 13:04:23,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54517/tests/dromaeo/cssquery-ext.html) 13:04:25 INFO - 2015-11-03 13:04:25,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 337973248 13:04:25 INFO - 2015-11-03 13:04:25,155 DEBUG : BROWSER_OUTPUT: 13:07:27 INFO - 2015-11-03 13:07:27,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-ext.html (next: http://localhost:54517/tests/dromaeo/cssquery-jquery.html) 13:07:28 INFO - 2015-11-03 13:07:28,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 363294720 13:07:28 INFO - 2015-11-03 13:07:28,414 DEBUG : BROWSER_OUTPUT: 13:10:30 INFO - 2015-11-03 13:10:30,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54517/tests/dromaeo/cssquery-mootools.html) 13:10:31 INFO - 2015-11-03 13:10:31,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 326377472 13:10:31 INFO - 2015-11-03 13:10:31,427 DEBUG : BROWSER_OUTPUT: 13:13:33 INFO - 2015-11-03 13:13:33,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54517/tests/dromaeo/cssquery-prototype.html) 13:13:34 INFO - 2015-11-03 13:13:34,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 310337536 13:13:34 INFO - 2015-11-03 13:13:34,303 DEBUG : BROWSER_OUTPUT: 13:16:37 INFO - 2015-11-03 13:16:37,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54517/tests/dromaeo/cssquery-yui.html) 13:16:38 INFO - 2015-11-03 13:16:38,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 313606144 13:16:38 INFO - 2015-11-03 13:16:38,045 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/dromaeo/cssquery-yui.html (next: http://localhost:54517/tests/dromaeo/cssquery-dojo.html) 13:19:41 INFO - 2015-11-03 13:19:41,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 364666880 13:19:41 INFO - 2015-11-03 13:19:41,353 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,354 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:19:41 INFO - 2015-11-03 13:19:41,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:19:41 INFO - 2015-11-03 13:19:41,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:19:41 INFO - 2015-11-03 13:19:41,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:19:41 INFO - 2015-11-03 13:19:41,356 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2824.661040675119;2838.3897462045657;2860.8140470869394;2875.051233093081;2918.489264378733;4756.595689366408;4848.63635227358;4855.320255164271;4859.586935110516;4880.536349046839;4808.639352048593;4816.181249187629;4859.343988561552;4913.0910781505445;4928.654994150411;4522.796474158671;4550.067236216584;4592.586667199951;4617.053504031683;4667.5332466753225;4619.976900115495;4650.674452788307;4706.411698537683;4724.527547245265;4741.976290118545;4394.4946331172005;4399.64802815774;4597.839075632337;4635.327877457767;4648.163330600491;4537.31940208968;4550.977245113786;4604.769761511944;4623.02916387559;4652.302154676826;4522.5025247222775;4534.501204867462;4575.473820510617;4603.355530225737;4614.077184563067;4692.648051396159;4720.480747117815;4804.231322988305;4877.707337559757;4885.60915126789;5153.6907785532985;5154.845354639367;5172.793088276464;5207.973960130213;5214.296070030536;5211.062008838408;5232.189010703347;5269.446708095633;5273.841784746463;5290.788368465257;4631.189541830133;4773.928391074137;4783.832565860178;4857.732824694675;4861.465238823726;5023.949760502348;5157.918315538012;5169.884747792276;5174.818881339135;5258.316418865523;4952.678075925053;5031.270465782441;5048.444671086178;5081.4918508148885;5108.489151084936;5007.324011258506;5211.114110601206;5212.957408518311;5251.553617942518;5263.894722105537;5107.974460127675;5110.897782044338;5116.923246151311;5150.356205474316;5186.5850731941355;5031.094403007421;5039.82360617384;5056.342675452168;5062.620303477254;5115.0792857285305;3971.702122340836;3980.283548961157;3982;3983.721139520264;4022.3765316376007;3526.8941931741574;3553.378158822196;3557.7153827693724;3626.111602657313;3641.417373220272;4772.308015337757;4796.5203479651755;4801.879953001203;4813.7593120344545;4831.130396528588;4999.975000124976;5112.616553758483;5159.690418574897;5179.896402071938;5187.766550505236;4684.250519916797;4712.95287047132;4752.643551733565;4762.452317983407;4785.090832741768;4512.842050528281;4532.88667783308;4574.611158051536;4603.9079218415445;4617.792199351037;5078.822241221539;5126.6923984561045;5221.712805795718;5226.059309324358;5301.920471192935;5160.225966105114;5207.088759467002;5230.529252367305;5239.81660641891;5293.206019097166;5200.427952925251;5229.947700522946;5264.341957255343;5267.157254839208;5304.761285742074;4968.652194346506;5100.2349647553165;5152.098382783073;5180.197069454241;5183.041137389444;5168.147255702767;5196.454372290855;5210.53105220532;5221.660592061504;5257.710825904459;5094.490550944876;5108.540231379194;5124.692518448905;5129.384473863161;5211.71335576547;4798.808047678054;4939.431965324034;5062.468440813662;5068.974655126701;5092.108880945893;4773.928391074206;4876.829310974099;4930;4947.851564453073;5005.099082165099;5050.797968081236;5076.7207803571155;5077.339945807022;5149.124648809637;5198.402183748917;4756.667033307635;4809.0862736080035;4975.626827987843;4978.4274808397495;5015.5987520997505 13:19:41 INFO - 2015-11-03 13:19:41,360 DEBUG : BROWSER_OUTPUT: |1;ext.html;476.57346674726114;482.9348038014867;490.0762063510284;498.7755510020489;505.9223853192699;28629.427411451758;29432.41135177298;34724.65275347249;36291.2741745165;36314.45528317078;37428.625713742855;37817.43273850894;37915;37968.620313796855;38002.4299635505;7300.671469783872;8036.638351274192;8235;8327.750167494985;8344.707935222268;7290.380317673004;9416.576254068548;9480.573374198178;9620.230381569492;9648;9751.90248097517;9772.31593788435;9782.608695652165;9875.950620246924;9886.950565247163;7355.5586664800285;7587.430942679322;9440.480773557452;9745.756356091119;9930.05664461875;9596.32825702201;9650.662226822098;9763.707088787347;9784.070513301225;9801.068898454636;33637.159071023176;34078.1480462988;34511;34528;34609;2567.011700495304;2656.787457003435;2765.477900111693;2818.119894395078;2996.4456575533595;24000.159994400114;24380.26859194227;24720.752792472023;24740.25779226626;25228.621570676456;2110.366889933014;2118.9682154767693;2151.3008272311563;2282.4065742906796;2294.5869743446174;240534;242636;243738;243837;244787;43273.56726432758;44915.55084449179;51536.742316288175;51659.741701292005;51726.22410663843;42007.369889451686;53437.1984420234;53620.73189634105;54279;54449.1832622511;13941.093828901088;13962.441502339792;14187.14877107377;14228.14631122136;14264;10811.6215932442;10825.296355736851;10876.129909607213;10890.346579205274;10908.61819836302;15869.920650396905;16146.19269036567;16289.266982985793;16328.67342653164;16411.261493232832;7349.669264883093;7540.245975402416;7580.734674286374;7609.923900760921;7673.501222420637;791.9326857217201;795.5425630262622;859.1794835931795;867.6442658509981;872;23698.526029479315;24025;24027.159049433187;24080.397990050038;24417.633735493982;967.1489089601247;970.8301047316833;1020.5815615597569;1076.0530732955106;1113.0705860606483;12703.174293670882;13053.216806991612;13352.866471335163;13411.597652070453;13542.45830166802;278327;285949;286215;288191;288251;47955.5204447958;48309.275360869615;48319.27521087186;48372.7581362098;48450.27324590134;1229.2685851918095;1237.4369661803858;1239.9814002790147;1240.076143273249;1255.2719422734792;21555.353339399844;24836.627450588618;25108.874455627603;25307.367315817253;25338.239852804447;42750.35874461948;43285;43315.78342108269;43353.783231083646;43356.132877341646;238952;241454;242953;243074;244448;23228;23420.531589367776;23737.762622374245;26181.607275890496;26427;33138.83430582831;33145.83427082849;33168.1707957303;33227;33376.49935250924;27782.166535003984;28250;29095.854520727262;29899.402011960075;30326.696733032386;29265.268368290963;29736.851315743283;29824;29921.102366929026;30110.09669709912;28680.282992925342;29475.705242948156;29499.410011799213;29862.552061718656;29873.70126298796;25581.23256302314;26394.472110558065;26722.732772672804;26980.1905942822;27337.31656708598;19528.707069393688;19766.802331976498;19930.60138797245;20050.699239511127;20116.698249525976 13:19:41 INFO - 2015-11-03 13:19:41,360 DEBUG : BROWSER_OUTPUT: |2;jquery.html;293.3502292422284;294.929216987923;299.89653569518515;300.7263390314814;301.8943369820563;12809.359532023385;13320.40058197381;15176.544703658894;15430.305636246369;15886.364545418184;13430.731385372286;15580.766288505652;16374.918125409386;16652.75020874685;16871.578210544743;4625.121226966882;4631.39791827062;4643.8142474300985;4685.5548722871445;4695.577398034176;3379.8648054077808;3513.4729790531496;3555.1645363339594;4743.833965811197;4854.223324268118;5087.898242035157;5222.138347172712;5243.554297884665;5304.283921670583;5312.123499622577;5145.794168233266;5213.817516386946;5247.134222853225;5264.263003179558;5275.577953763709;4475.820967161309;4497.505274419811;4500.819967201308;4555.08898220354;4561.019380833103;19054.42836714901;19230.230790768353;19321.51696207592;19383.03084845752;19385.41843744676;1879.6898511745546;1941.9611607767765;2116.661334186538;2188.1684959715208;2227.3652009177467;11540.192186546945;11750.23623464472;11900;12047.879521204852;12422;1391.373881753205;1416.157386355117;1447.0955652717053;1472.9410823567046;1482.621931407495;49580.75209623965;50613.987720245386;50664.746676266754;50871.23693144606;52418.737906310605;8493.787655308543;8607.450658881336;8829.16122968317;8855.690050848189;8883.156100170474;10867.565297388173;10877.83683244752;10884.782304353868;11000.669979900616;11023.06303964156;7120.181179164359;7231.819204519929;7268.382187514015;7295.92066261113;7353.705851765976;7416.0729908761405;7425.925740742631;7446.255374462618;7467.103947526223;7481;5197.688138711689;5277.525022747895;5305;5332.573394128461;5334.293026231646;1370.5066176176767;1434.1610158057445;1440.8847292216808;1469.3836779542632;1537.2851623994895;341.26287219605535;351.1372170634756;828.8176601147737;877.7630039889194;956.6125719083782;8943.731688049369;9142.680006199884;9404.38871473352;9450.952745236367;9605.711828645151;363.12849162011383;379.62796459469877;383.9404892241707;391.5340744514076;392.95088113985753;5091.719955402488;5114.130597798308;5119.360079990001;5146.76839542214;5160.509751573594;459560;460541;468301;478481;499911;60376.698116510015;60497;60660.09009864856;61216.38783612196;63935.36064639294;379.508536445304;383.2239714578002;383.8483798899419;385.89580813180845;386.66167103784187;8864.64541418336;8872.689455869271;8881.59693738047;8903.376763626484;8946.910530894607;31040.22399440032;31172.37655246928;31215;31286.687133128376;31709.524357135124;41964.790176048926;42186.78906605447;42266.788666056476;42384.78807605942;42600.360994585724;6711.966440167768;6841.623710695761;6879.2432832389395;6907.620080895599;6926.792196234121;10333.276670633284;10351.844722329322;10388.48057597102;10610.098141658045;10646.414447205478;7523.623818809147;7831.2560306770765;7918.564478953713;8621.180987806149;8821.514816685143;8205.717712914882;8576.957115214384;8655.826883462421;8732.257758090633;8750.60622272012;8922;9109.089091090838;9244.722658320261;9360.719178424659;9506.572204250964;6755.6622168892345;6770.898436523357;6788.321167883172;6847.828804279933;6934.4452443805385;8937.374383793072;9022.729318120468;9062.275017998676;9157.908420915972;9186.173244408035 13:19:41 INFO - 2015-11-03 13:19:41,364 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.382427907442;1508.9170095644738;1556.9688606227876;1595.625028118392;1600.6958677851208;6025.7288422021;6342.429181373675;6387.968060159705;6575.7040933158005;6579.868402631956;6386.489080873531;6466.547341686084;6532.771353002646;6537.444317233041;6632.369924857143;1711.0247159119308;1727.4040456042708;1907.2943011085918;1907.3419670213755;1907.9427617171507;1921.3371386871506;1975.4370004548707;1986.8410527157794;1996.620642078008;2007.3175120459114;1875;1896.0993528074123;1914.2438736699064;1919.9040047997614;1947.8149575790278;1887.7923428422862;1922.2311075569744;1927.5855691026356;1944.8638595298335;1947.9415617531427;1873.653374125791;1895.9810401895943;1897.7343171955938;1899.335232668555;1925.9037048147536;6470.741170353227;6554.705038273241;6638.435732962704;6647.66761661915;6654.534182607219;4039.7576145431367;4143.585641435832;4176;4177.749335039907;4183.644390226835;2512.522620702079;2566.2814411964678;2614.542455070355;2619.8035147363835;2622.6066090086447;720.3984672798167;736.4255880413286;742.9665665045086;785.1834092543804;792.1998781230941;8343.290820280283;8395.454295470774;8506.191911768434;8516.787080323042;8523.360747943867;3664.1022949377575;3702.7222958278235;3755.9061023474087;3766.7928263945196;3798.2783271178387;7316.597587132759;7325.194228634846;7400.074990626172;7411.925880741232;7412.740554080581;4133.421321015;4157.875263742093;4168.458100446923;4174.290370636999;4177.791110444466;3766.849326026983;3779.981100094482;3781.470594116826;3817.6945844332386;3817.7327587069194;2904.2013446302435;3022.576839242508;3123.828564288392;3153.6057992750907;3215.485522316418;1038.159091136182;1046.1421634259834;1046.9214808889365;1049.5959055763433;1053.7049626104704;897.7890195803981;898.8292224477328;934.8550974598948;957.5116690487902;1186.9703257418635;6137.355577664371;6211;6294.370562943761;6296.590721603081;6302.558820882586;1012.9088382045651;1017.5777052523268;1029.3978022856713;1040.7138037039724;1059.3114475590928;4918.5573298403315;4971.2543118531785;4979.203327467588;5057.8229761958155;5059.62052846038;7045.964770176116;7369.668364923591;7396.149442814038;7455.366293864974;7477.252274772588;7562.0925488941675;7582.54504729718;7667.808304792313;7674.079110506775;7679.654415551314;6026.246719160105;6068.302145253264;6131.448169664752;6171.475424588871;6174.25908890936;6115.510759139347;6120.3267640558615;6163.7842675506145;6186.412290832363;6202.100695399232;6428.389303016206;6734.595924244365;6777.593344399352;6925.688344024632;6949.617771022642;6766.560173588701;6824.283450237654;6883.380495755406;6888.621125838127;6968.024476573182;5211.713355765318;5344.732763361894;5352.4915133062295;5355.598330125178;5361.731913404236;5770.740316685676;5913.46778789911;5941.049432090845;6195.411435913581;6270.028145637433;5829.854253643693;5878.2064421302575;5979.611325263844;6000.729967151401;6022.337542870193;5597.732918167985;5602.215689803349;5654.378018417889;5841.795537156179;5875.882482350415;5576.163575463551;5616.1856530803625;5647.802326918538;5650;5650.180723795109;5367.570594352364;5413.621046526705;5427.674339539641;5457.072297709319;5467.343918729778;5517.724113794375;5532;5546.528545073553;5548.778048878;5591.356993945748 13:19:41 INFO - 2015-11-03 13:19:41,364 DEBUG : BROWSER_OUTPUT: |4;prototype.html;268.81854748045066;281.4666207536717;284.06967182477376;285.9270885924089;286.76915083357886;5256.894862102756;5293.470652934714;5368.597355198361;5425.782968681253;5446.9182962255545;5112.795488180478;5202.4537423570455;5276.736163191835;5287.021900948327;5291.391489978653;4174.874753757392;4177.206330797138;4197.79011049447;4215.894602634928;4221.0291632924445;4020.597940205985;4070.3894415837567;4109.938350924738;4186.916261674764;4222.429971953793;4048;4114.465119534456;4174.70777045607;4188.078622703016;4192.811323490435;4124.6906482013665;4167.416561681367;4170.124273902454;4173.707840451169;4178.561251068655;3582.8566857325677;3589.10272431892;3627;3634.691051260646;3635.2366003139373;4964;5108.463611320833;5161.458046905096;5172.172452407597;5174.7412629368755;4620.075984803019;4626.745528995903;4663.207254766698;4664.95335046652;4667.719936803769;5623.746931388097;5627.493525582676;5636.74634641438;5638.04153293941;5643.351014633328;3874.5156855393075;3894.6689531389866;3919.510061242345;3921.3333733265413;3922.666573341269;5388.326459192601;5571.220029195916;5650.51970582501;5823.5341172706085;5874.853128671774;3771.660550550409;3814.504114465102;3863.613638636114;3871.787051712183;3937.547182074098;3960.108975480494;3963.504561929759;3978.622030907059;3987.222491614107;4001.1797581495725;4537.22867112585;4543.363929049936;4546.840860569864;4568.406107206042;4572.542745725401;5479.808206712746;5543.1408131739645;5554.91667624986;5628.774849005994;5636.323641163087;1336.8663133686748;1393.171063217384;1396.6578188343922;1399.7060617270488;1408.2254759882023;892.7455675132686;896.3635818568758;902.1609902790468;906.4833045164324;920.1948295241664;5187.481251874782;5200.5059519345605;5206.140986737221;5275.340582427197;5276.551493123127;5651.745671444794;5696.11710184922;5763.567732420085;5768.4808367246305;5783.508401785811;5191.870203244874;5233.607479439057;5249.055170069424;5317.946820531823;5326.92009619856;3157.2422618571377;3183.1405520509334;3239.9838000809846;3241.62721287055;3245.724113450336;5822.883542329129;5828.6502809831545;5874.647521148745;5882.441168089024;5926;5763.452472015152;5962.07587823888;5978.372270911578;5980.820575382745;5990.9700451497465;5914.852128696817;5960.284765827955;5962;5964.552658550626;5967.940320596826;5878.382769809279;5914.645121292736;5927.051671732502;5929.199558059607;5932.911006334994;5611.438856114356;5708.343540492897;5810.01229790945;5819.243498345188;5830.912536312044;5936.910946335722;5945.762169513344;5945.851353716019;5969.044952807703;5996.37038110992;3859.671927886161;3868.2070175613367;3892.4161375793856;3897.162110146332;3916.569177390542;5785.56608254391;5797.188393624811;5885.323187833454;5888.440598143169;5912.113183022409;5493.423190565093;5695.601307908407;5699.601027928005;5732.226149469935;5740.339860916049;5675.971620141873;5695.401982791747;5709.65742055478;5737.282839645044;5754.683492407958;5524.364698059774;5529.225908372911;5595.944040559542;5595.944040559705;5597.412271711574;5559.388467268678;5666.801661941977;5673.8865222694485;5690.4878560928055;5754.309482862083;5519.199716041232;5576.10782274834;5576.33084029919;5577.051901176891;5594.776208951596 13:19:41 INFO - 2015-11-03 13:19:41,368 DEBUG : BROWSER_OUTPUT: |5;yui.html;636.8121404185765;663.6117871045439;675.324675324675;679.3647939176867;687.840987935329;12095.395230238486;12269.509219631203;12347;12351;12483.375831208426;11423.942880285587;11596;11606.129540284492;11699.29804211748;11712.882871171285;621.8694074244414;624.4036944717784;803.4536515169682;805.7139715401037;816.5957850863831;816.6570040582969;822.3873214455239;830.5390508267939;831.7255305749119;839.2488722593275;851.5997481183833;856.824351008045;863.0592654007131;864.1229152410309;865.1564724393697;630.0423356498143;638.450932198309;831.3806214370333;847.449158047268;852.3394369363731;622.0420552349376;627.4541149200179;627.6704730016733;630.2342653675806;632.0834789555117;10896.40069796161;11040.944795276053;11063.280886742417;11174.497147628295;11187.944060279728;9933.75165620858;10304.381737095724;10427.113695335906;10806.18953578477;10860.076893464066;8550.70072547464;8597.4841509509;8696.652133914637;8698.913010869937;9053.321000924958;2678.6919504257066;2688.193541937411;2689.3007817967273;2740.4930087933794;2747.7114902935305;40922.590774092176;41333.1733365331;41513.79243103795;41927.161456771;41993.1601367974;5820.563457740602;5852.882942341129;5909.8227053188475;6008.4592386684535;6022.849428764316;10325.48372581368;10327.74180645475;10429.843552346721;10449.84325235122;10460.843087353696;5341.0653135701095;5498.642588231752;5584.246126772834;5615.9157612635845;5637.633553819071;3215;3225.5000474926424;3346.54821599081;3516.033090900023;3583.0684022153905;2380.5714971304983;2380.73811880693;2388.0328466970905;2407.5064611754897;2421.418859473714;358.4336747938251;362.3333067156445;363.8926516677586;365.51204142469567;367.8216065208372;372.8154563491035;377.95464544254867;423.9152169566099;437.4073130907638;447.679908865163;6550.508711846631;6596.571222870498;6607.4383677386995;6611.603303801788;6729.024291477708;392.0571026680837;481.33575665581975;508.6134537751262;518.2948100748571;522.8954209158107;3133.937321253562;3198.1844629619764;3272.296456261915;3592.7485076044427;3713.2573485302505;49705;50533;50705.746471267405;50712;50793.238101428506;43293.35059974103;43599;44399.11201776011;44659.33011004837;44889.77555112204;39169.608303917164;39291;40405.79797100995;40875.386869196984;41052.9999999994;6451.483881289391;6846.178458585002;6863.38229559342;7015.649217539205;7015.719371225094;31537.8423107883;31706;31957.520637189995;32751.508727368633;32764.344713106082;42202;42219;42655;42849.35725964051;42983.570164297955;6187.907181392373;6351.301356850835;6821.761238356832;7030.718771249093;7091.1490621125795;9782.80434391294;9791;9933.552990115317;10474.738131546468;10491.213159013258;8717.389782715149;9153.450792952444;9159.725208243763;9386.45123554606;9556.90443095588;9102.544872756469;9270.721878343391;9510.008694522407;9541.045895410403;9821.85267220978;8902.109789021046;9200.95399522998;9471.431714097176;9491.620335186515;9869.851952220866;7611.124720657195;7735.535867847947;7814.609269536614;7897.956656346749;8333.83332333362;7205.567665940061;7317.524360916524;7637.121731001006;7747.961260193663;7833.5691536966015 13:19:41 INFO - 2015-11-03 13:19:41,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: __startTimestamp1446585581353__endTimestamp 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:19:41 INFO - 2015-11-03 13:19:41,369 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4818.29 Median:4947.85 stddev:504.44 (10.2%) stddev-sans-first:481.13 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: Values: 2824.7 2838.4 2860.8 2875.1 2918.5 4756.6 4848.6 4855.3 4859.6 4880.5 4808.6 4816.2 4859.3 4913.1 4928.7 4522.8 4550.1 4592.6 4617.1 4667.5 4620.0 4650.7 4706.4 4724.5 4742.0 4394.5 4399.6 4597.8 4635.3 4648.2 4537.3 4551.0 4604.8 4623.0 4652.3 4522.5 4534.5 4575.5 4603.4 4614.1 4692.6 4720.5 4804.2 4877.7 4885.6 5153.7 5154.8 5172.8 5208.0 5214.3 5211.1 5232.2 5269.4 5273.8 5290.8 4631.2 4773.9 4783.8 4857.7 4861.5 5023.9 5157.9 5169.9 5174.8 5258.3 4952.7 5031.3 5048.4 5081.5 5108.5 5007.3 5211.1 5213.0 5251.6 5263.9 5108.0 5110.9 5116.9 5150.4 5186.6 5031.1 5039.8 5056.3 5062.6 5115.1 3971.7 3980.3 3982.0 3983.7 4022.4 3526.9 3553.4 3557.7 3626.1 3641.4 4772.3 4796.5 4801.9 4813.8 4831.1 5000.0 5112.6 5159.7 5179.9 5187.8 4684.3 4713.0 4752.6 4762.5 4785.1 4512.8 4532.9 4574.6 4603.9 4617.8 5078.8 5126.7 5221.7 5226.1 5301.9 5160.2 5207.1 5230.5 5239.8 5293.2 5200.4 5229.9 5264.3 5267.2 5304.8 4968.7 5100.2 5152.1 5180.2 5183.0 5168.1 5196.5 5210.5 5221.7 5257.7 5094.5 5108.5 5124.7 5129.4 5211.7 4798.8 4939.4 5062.5 5069.0 5092.1 4773.9 4876.8 4930.0 4947.9 5005.1 5050.8 5076.7 5077.3 5149.1 5198.4 4756.7 4809.1 4975.6 4978.4 5015.6 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40255.95 Median:29618.13 stddev:67328.95 (227.3%) stddev-sans-first:67451.58 13:19:41 INFO - 2015-11-03 13:19:41,370 DEBUG : BROWSER_OUTPUT: Values: 476.6 482.9 490.1 498.8 505.9 28629.4 29432.4 34724.7 36291.3 36314.5 37428.6 37817.4 37915.0 37968.6 38002.4 7300.7 8036.6 8235.0 8327.8 8344.7 7290.4 9416.6 9480.6 9620.2 9648.0 9751.9 9772.3 9782.6 9876.0 9887.0 7355.6 7587.4 9440.5 9745.8 9930.1 9596.3 9650.7 9763.7 9784.1 9801.1 33637.2 34078.1 34511.0 34528.0 34609.0 2567.0 2656.8 2765.5 2818.1 2996.4 24000.2 24380.3 24720.8 24740.3 25228.6 2110.4 2119.0 2151.3 2282.4 2294.6 240534.0 242636.0 243738.0 243837.0 244787.0 43273.6 44915.6 51536.7 51659.7 51726.2 42007.4 53437.2 53620.7 54279.0 54449.2 13941.1 13962.4 14187.1 14228.1 14264.0 10811.6 10825.3 10876.1 10890.3 10908.6 15869.9 16146.2 16289.3 16328.7 16411.3 7349.7 7540.2 7580.7 7609.9 7673.5 791.9 795.5 859.2 867.6 872.0 23698.5 24025.0 24027.2 24080.4 24417.6 967.1 970.8 1020.6 1076.1 1113.1 12703.2 13053.2 13352.9 13411.6 13542.5 278327.0 285949.0 286215.0 288191.0 288251.0 47955.5 48309.3 48319.3 48372.8 48450.3 1229.3 1237.4 1240.0 1240.1 1255.3 21555.4 24836.6 25108.9 25307.4 25338.2 42750.4 43285.0 43315.8 43353.8 43356.1 238952.0 241454.0 242953.0 243074.0 244448.0 23228.0 23420.5 23737.8 26181.6 26427.0 33138.8 33145.8 33168.2 33227.0 33376.5 27782.2 28250.0 29095.9 29899.4 30326.7 29265.3 29736.9 29824.0 29921.1 30110.1 28680.3 29475.7 29499.4 29862.6 29873.7 25581.2 26394.5 26722.7 26980.2 27337.3 19528.7 19766.8 19930.6 20050.7 20116.7 13:19:41 INFO - 2015-11-03 13:19:41,371 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,372 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24252.89 Median:27217.49 stddev:77381.24 (284.3%) stddev-sans-first:77577.40 13:19:41 INFO - 2015-11-03 13:19:41,373 DEBUG : BROWSER_OUTPUT: Values: 293.4 294.9 299.9 300.7 301.9 12809.4 13320.4 15176.5 15430.3 15886.4 13430.7 15580.8 16374.9 16652.8 16871.6 4625.1 4631.4 4643.8 4685.6 4695.6 3379.9 3513.5 3555.2 4743.8 4854.2 5087.9 5222.1 5243.6 5304.3 5312.1 5145.8 5213.8 5247.1 5264.3 5275.6 4475.8 4497.5 4500.8 4555.1 4561.0 19054.4 19230.2 19321.5 19383.0 19385.4 1879.7 1942.0 2116.7 2188.2 2227.4 11540.2 11750.2 11900.0 12047.9 12422.0 1391.4 1416.2 1447.1 1472.9 1482.6 49580.8 50614.0 50664.7 50871.2 52418.7 8493.8 8607.5 8829.2 8855.7 8883.2 10867.6 10877.8 10884.8 11000.7 11023.1 7120.2 7231.8 7268.4 7295.9 7353.7 7416.1 7425.9 7446.3 7467.1 7481.0 5197.7 5277.5 5305.0 5332.6 5334.3 1370.5 1434.2 1440.9 1469.4 1537.3 341.3 351.1 828.8 877.8 956.6 8943.7 9142.7 9404.4 9451.0 9605.7 363.1 379.6 383.9 391.5 393.0 5091.7 5114.1 5119.4 5146.8 5160.5 459560.0 460541.0 468301.0 478481.0 499911.0 60376.7 60497.0 60660.1 61216.4 63935.4 379.5 383.2 383.8 385.9 386.7 8864.6 8872.7 8881.6 8903.4 8946.9 31040.2 31172.4 31215.0 31286.7 31709.5 41964.8 42186.8 42266.8 42384.8 42600.4 6712.0 6841.6 6879.2 6907.6 6926.8 10333.3 10351.8 10388.5 10610.1 10646.4 7523.6 7831.3 7918.6 8621.2 8821.5 8205.7 8577.0 8655.8 8732.3 8750.6 8922.0 9109.1 9244.7 9360.7 9506.6 6755.7 6770.9 6788.3 6847.8 6934.4 8937.4 9022.7 9062.3 9157.9 9186.2 13:19:41 INFO - 2015-11-03 13:19:41,373 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,373 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4539.93 Median:5583.76 stddev:2260.64 (40.5%) stddev-sans-first:2254.45 13:19:41 INFO - 2015-11-03 13:19:41,375 DEBUG : BROWSER_OUTPUT: Values: 1372.4 1508.9 1557.0 1595.6 1600.7 6025.7 6342.4 6388.0 6575.7 6579.9 6386.5 6466.5 6532.8 6537.4 6632.4 1711.0 1727.4 1907.3 1907.3 1907.9 1921.3 1975.4 1986.8 1996.6 2007.3 1875.0 1896.1 1914.2 1919.9 1947.8 1887.8 1922.2 1927.6 1944.9 1947.9 1873.7 1896.0 1897.7 1899.3 1925.9 6470.7 6554.7 6638.4 6647.7 6654.5 4039.8 4143.6 4176.0 4177.7 4183.6 2512.5 2566.3 2614.5 2619.8 2622.6 720.4 736.4 743.0 785.2 792.2 8343.3 8395.5 8506.2 8516.8 8523.4 3664.1 3702.7 3755.9 3766.8 3798.3 7316.6 7325.2 7400.1 7411.9 7412.7 4133.4 4157.9 4168.5 4174.3 4177.8 3766.8 3780.0 3781.5 3817.7 3817.7 2904.2 3022.6 3123.8 3153.6 3215.5 1038.2 1046.1 1046.9 1049.6 1053.7 897.8 898.8 934.9 957.5 1187.0 6137.4 6211.0 6294.4 6296.6 6302.6 1012.9 1017.6 1029.4 1040.7 1059.3 4918.6 4971.3 4979.2 5057.8 5059.6 7046.0 7369.7 7396.1 7455.4 7477.3 7562.1 7582.5 7667.8 7674.1 7679.7 6026.2 6068.3 6131.4 6171.5 6174.3 6115.5 6120.3 6163.8 6186.4 6202.1 6428.4 6734.6 6777.6 6925.7 6949.6 6766.6 6824.3 6883.4 6888.6 6968.0 5211.7 5344.7 5352.5 5355.6 5361.7 5770.7 5913.5 5941.0 6195.4 6270.0 5829.9 5878.2 5979.6 6000.7 6022.3 5597.7 5602.2 5654.4 5841.8 5875.9 5576.2 5616.2 5647.8 5650.0 5650.2 5367.6 5413.6 5427.7 5457.1 5467.3 5517.7 5532.0 5546.5 5548.8 5591.4 13:19:41 INFO - 2015-11-03 13:19:41,375 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,375 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4696.76 Median:5322.43 stddev:1414.73 (26.6%) stddev-sans-first:1379.10 13:19:41 INFO - 2015-11-03 13:19:41,376 DEBUG : BROWSER_OUTPUT: Values: 268.8 281.5 284.1 285.9 286.8 5256.9 5293.5 5368.6 5425.8 5446.9 5112.8 5202.5 5276.7 5287.0 5291.4 4174.9 4177.2 4197.8 4215.9 4221.0 4020.6 4070.4 4109.9 4186.9 4222.4 4048.0 4114.5 4174.7 4188.1 4192.8 4124.7 4167.4 4170.1 4173.7 4178.6 3582.9 3589.1 3627.0 3634.7 3635.2 4964.0 5108.5 5161.5 5172.2 5174.7 4620.1 4626.7 4663.2 4665.0 4667.7 5623.7 5627.5 5636.7 5638.0 5643.4 3874.5 3894.7 3919.5 3921.3 3922.7 5388.3 5571.2 5650.5 5823.5 5874.9 3771.7 3814.5 3863.6 3871.8 3937.5 3960.1 3963.5 3978.6 3987.2 4001.2 4537.2 4543.4 4546.8 4568.4 4572.5 5479.8 5543.1 5554.9 5628.8 5636.3 1336.9 1393.2 1396.7 1399.7 1408.2 892.7 896.4 902.2 906.5 920.2 5187.5 5200.5 5206.1 5275.3 5276.6 5651.7 5696.1 5763.6 5768.5 5783.5 5191.9 5233.6 5249.1 5317.9 5326.9 3157.2 3183.1 3240.0 3241.6 3245.7 5822.9 5828.7 5874.6 5882.4 5926.0 5763.5 5962.1 5978.4 5980.8 5991.0 5914.9 5960.3 5962.0 5964.6 5967.9 5878.4 5914.6 5927.1 5929.2 5932.9 5611.4 5708.3 5810.0 5819.2 5830.9 5936.9 5945.8 5945.9 5969.0 5996.4 3859.7 3868.2 3892.4 3897.2 3916.6 5785.6 5797.2 5885.3 5888.4 5912.1 5493.4 5695.6 5699.6 5732.2 5740.3 5676.0 5695.4 5709.7 5737.3 5754.7 5524.4 5529.2 5595.9 5595.9 5597.4 5559.4 5666.8 5673.9 5690.5 5754.3 5519.2 5576.1 5576.3 5577.1 5594.8 13:19:41 INFO - 2015-11-03 13:19:41,377 DEBUG : BROWSER_OUTPUT: 13:19:41 INFO - 2015-11-03 13:19:41,377 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11622.85 Median:2931.98 stddev:14231.16 (485.4%) stddev-sans-first:14247.17 13:19:41 INFO - 2015-11-03 13:19:41,377 DEBUG : BROWSER_OUTPUT: Values: 636.8 663.6 675.3 679.4 687.8 12095.4 12269.5 12347.0 12351.0 12483.4 11423.9 11596.0 11606.1 11699.3 11712.9 621.9 624.4 803.5 805.7 816.6 816.7 822.4 830.5 831.7 839.2 851.6 856.8 863.1 864.1 865.2 630.0 638.5 831.4 847.4 852.3 622.0 627.5 627.7 630.2 632.1 10896.4 11040.9 11063.3 11174.5 11187.9 9933.8 10304.4 10427.1 10806.2 10860.1 8550.7 8597.5 8696.7 8698.9 9053.3 2678.7 2688.2 2689.3 2740.5 2747.7 40922.6 41333.2 41513.8 41927.2 41993.2 5820.6 5852.9 5909.8 6008.5 6022.8 10325.5 10327.7 10429.8 10449.8 10460.8 5341.1 5498.6 5584.2 5615.9 5637.6 3215.0 3225.5 3346.5 3516.0 3583.1 2380.6 2380.7 2388.0 2407.5 2421.4 358.4 362.3 363.9 365.5 367.8 372.8 378.0 423.9 437.4 447.7 6550.5 6596.6 6607.4 6611.6 6729.0 392.1 481.3 508.6 518.3 522.9 3133.9 3198.2 3272.3 3592.7 3713.3 49705.0 50533.0 50705.7 50712.0 50793.2 43293.4 43599.0 44399.1 44659.3 44889.8 39169.6 39291.0 40405.8 40875.4 41053.0 6451.5 6846.2 6863.4 7015.6 7015.7 31537.8 31706.0 31957.5 32751.5 32764.3 42202.0 42219.0 42655.0 42849.4 42983.6 6187.9 6351.3 6821.8 7030.7 7091.1 9782.8 9791.0 9933.6 10474.7 10491.2 8717.4 9153.5 9159.7 9386.5 9556.9 9102.5 9270.7 9510.0 9541.0 9821.9 8902.1 9201.0 9471.4 9491.6 9869.9 7611.1 7735.5 7814.6 7898.0 8333.8 7205.6 7317.5 7637.1 7748.0 7833.6 13:19:41 INFO - 2015-11-03 13:19:41,377 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:19:41 INFO - 2015-11-03 13:19:41,377 DEBUG : BROWSER_OUTPUT: 13:19:42 INFO - 2015-11-03 13:19:42,058 INFO : Browser exited with error code: 0 13:19:42 INFO - 2015-11-03 13:19:42,089 INFO : Completed test dromaeo_css (00:18:35) 13:19:42 INFO - 2015-11-03 13:19:42,089 INFO : Starting test kraken 13:19:42 INFO - 2015-11-03 13:19:42,089 DEBUG : operating with platform_type : mac_ 13:19:42 INFO - 2015-11-03 13:19:42,089 INFO : Initialising browser for kraken test... 13:19:42 INFO - 2015-11-03 13:19:42,104 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpiqOEGD/profile http://localhost:54517/getInfo.html 13:19:44 INFO - 2015-11-03 13:19:44,521 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:19:44 INFO - 2015-11-03 13:19:44,521 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:19:44 INFO - 2015-11-03 13:19:44,522 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:19:44 INFO - 2015-11-03 13:19:44,522 DEBUG : BROWSER_OUTPUT: __metrics 13:19:44 INFO - 2015-11-03 13:19:44,537 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:45 INFO - 2015-11-03 13:19:45,292 INFO : Browser initialized. 13:19:45 INFO - 2015-11-03 13:19:45,293 INFO : Running cycle 1/1 for kraken test... 13:19:45 INFO - 2015-11-03 13:19:45,293 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpiqOEGD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:19:57 INFO - 2015-11-03 13:19:57,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 220635136 13:19:57 INFO - 2015-11-03 13:19:57,314 DEBUG : BROWSER_OUTPUT: 13:20:00 INFO - 2015-11-03 13:20:00,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54517/tests/kraken/driver.html?testName=audio-beat-detection) 13:20:00 INFO - 2015-11-03 13:20:00,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 277889024 13:20:00 INFO - 2015-11-03 13:20:00,691 DEBUG : BROWSER_OUTPUT: 13:20:03 INFO - 2015-11-03 13:20:03,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54517/tests/kraken/driver.html?testName=audio-dft) 13:20:04 INFO - 2015-11-03 13:20:04,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 291409920 13:20:04 INFO - 2015-11-03 13:20:04,210 DEBUG : BROWSER_OUTPUT: 13:20:07 INFO - 2015-11-03 13:20:07,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54517/tests/kraken/driver.html?testName=audio-fft) 13:20:08 INFO - 2015-11-03 13:20:08,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 275542016 13:20:08 INFO - 2015-11-03 13:20:08,018 DEBUG : BROWSER_OUTPUT: 13:20:10 INFO - 2015-11-03 13:20:10,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54517/tests/kraken/driver.html?testName=audio-oscillator) 13:20:10 INFO - 2015-11-03 13:20:10,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 277504000 13:20:10 INFO - 2015-11-03 13:20:10,821 DEBUG : BROWSER_OUTPUT: 13:20:13 INFO - 2015-11-03 13:20:13,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54517/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:13 INFO - 2015-11-03 13:20:13,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 277594112 13:20:13 INFO - 2015-11-03 13:20:13,796 DEBUG : BROWSER_OUTPUT: 13:20:17 INFO - 2015-11-03 13:20:17,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54517/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:17 INFO - 2015-11-03 13:20:17,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 277524480 13:20:17 INFO - 2015-11-03 13:20:17,776 DEBUG : BROWSER_OUTPUT: 13:20:21 INFO - 2015-11-03 13:20:21,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54517/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:21 INFO - 2015-11-03 13:20:21,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 275435520 13:20:21 INFO - 2015-11-03 13:20:21,871 DEBUG : BROWSER_OUTPUT: 13:20:25 INFO - 2015-11-03 13:20:25,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54517/tests/kraken/driver.html?testName=json-parse-financial) 13:20:25 INFO - 2015-11-03 13:20:25,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 276205568 13:20:25 INFO - 2015-11-03 13:20:25,657 DEBUG : BROWSER_OUTPUT: 13:20:27 INFO - 2015-11-03 13:20:27,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54517/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:27 INFO - 2015-11-03 13:20:27,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 312303616 13:20:27 INFO - 2015-11-03 13:20:27,902 DEBUG : BROWSER_OUTPUT: 13:20:29 INFO - 2015-11-03 13:20:29,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:30 INFO - 2015-11-03 13:20:30,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 313446400 13:20:30 INFO - 2015-11-03 13:20:30,471 DEBUG : BROWSER_OUTPUT: 13:20:32 INFO - 2015-11-03 13:20:32,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:33 INFO - 2015-11-03 13:20:33,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 320110592 13:20:33 INFO - 2015-11-03 13:20:33,344 DEBUG : BROWSER_OUTPUT: 13:20:36 INFO - 2015-11-03 13:20:36,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:36 INFO - 2015-11-03 13:20:36,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 321564672 13:20:36 INFO - 2015-11-03 13:20:36,793 DEBUG : BROWSER_OUTPUT: 13:20:39 INFO - 2015-11-03 13:20:39,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:40 INFO - 2015-11-03 13:20:40,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 320114688 13:20:40 INFO - 2015-11-03 13:20:40,235 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54517/tests/kraken/driver.html?testName=ai-astar) 13:20:42 INFO - 2015-11-03 13:20:42,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 380026880 13:20:42 INFO - 2015-11-03 13:20:42,353 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: |0;ai-astar;119;123;123;130;123;121;121;122;119;128 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;180;149;177;186;149;168;168;148;187;143 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;181;181;193;183;180;181;182;181;182 13:20:42 INFO - 2015-11-03 13:20:42,355 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;93;99;142;78;79;79;79;134;77 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;112;113;159;104;104;108;145;100;99;151 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;129;135;134;135;129;135;143;130;136;142 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;141;141;154;146;141;141;146;147 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;119;118;113;117;119;119;118;113;117 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;63;65;65;68;68;69;78;68;64 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;74;79;75;74;78;79;76;75;74 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;100;101;100;101;96;96;101;101;101 13:20:42 INFO - 2015-11-03 13:20:42,356 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;145;147;146;147;157;145;141;148;149;143 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;159;172;177;178;164;161;173;177;180;160 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;77;79;78;82;81;83;79;79;79 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,944 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1446585642354__endTimestamp 13:20:42 INFO - 2015-11-03 13:20:42,357 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,359 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:20:42 INFO - 2015-11-03 13:20:42,359 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.90 Median:123.00 stddev:3.57 (2.9%) stddev-sans-first:3.50 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: Values: 119.0 123.0 123.0 130.0 123.0 121.0 121.0 122.0 119.0 128.0 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.50 Median:172.50 stddev:16.98 (9.8%) stddev-sans-first:17.18 13:20:42 INFO - 2015-11-03 13:20:42,360 DEBUG : BROWSER_OUTPUT: Values: 180.0 149.0 177.0 186.0 149.0 168.0 168.0 148.0 187.0 143.0 13:20:42 INFO - 2015-11-03 13:20:42,361 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,361 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.50 Median:181.50 stddev:3.78 (2.1%) stddev-sans-first:3.97 13:20:42 INFO - 2015-11-03 13:20:42,361 DEBUG : BROWSER_OUTPUT: Values: 181.0 181.0 181.0 193.0 183.0 180.0 181.0 182.0 181.0 182.0 13:20:42 INFO - 2015-11-03 13:20:42,361 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,361 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.80 Median:79.00 stddev:23.99 (30.4%) stddev-sans-first:25.32 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: Values: 88.0 93.0 99.0 142.0 78.0 79.0 79.0 79.0 134.0 77.0 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.50 Median:129.00 stddev:22.89 (17.7%) stddev-sans-first:24.11 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 159.0 104.0 104.0 108.0 145.0 100.0 99.0 151.0 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,362 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.80 Median:135.00 stddev:4.85 (3.6%) stddev-sans-first:4.67 13:20:42 INFO - 2015-11-03 13:20:42,363 DEBUG : BROWSER_OUTPUT: Values: 129.0 135.0 134.0 135.0 129.0 135.0 143.0 130.0 136.0 142.0 13:20:42 INFO - 2015-11-03 13:20:42,363 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,363 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:146.00 stddev:4.23 (2.9%) stddev-sans-first:4.35 13:20:42 INFO - 2015-11-03 13:20:42,363 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 141.0 141.0 154.0 146.0 141.0 141.0 146.0 147.0 13:20:42 INFO - 2015-11-03 13:20:42,363 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,365 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.10 Median:118.00 stddev:2.28 (1.9%) stddev-sans-first:2.40 13:20:42 INFO - 2015-11-03 13:20:42,365 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 118.0 113.0 117.0 119.0 119.0 118.0 113.0 117.0 13:20:42 INFO - 2015-11-03 13:20:42,365 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,365 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.90 Median:68.00 stddev:4.68 (6.9%) stddev-sans-first:4.45 13:20:42 INFO - 2015-11-03 13:20:42,365 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 65.0 65.0 68.0 68.0 69.0 78.0 68.0 64.0 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:75.50 stddev:2.55 (3.4%) stddev-sans-first:2.12 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 79.0 75.0 74.0 78.0 79.0 76.0 75.0 74.0 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.30 Median:101.00 stddev:2.31 (2.3%) stddev-sans-first:2.12 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: Values: 96.0 100.0 101.0 100.0 101.0 96.0 96.0 101.0 101.0 101.0 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,366 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:147.00 stddev:4.29 (2.9%) stddev-sans-first:4.50 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 147.0 157.0 145.0 141.0 148.0 149.0 143.0 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:175.00 stddev:8.25 (4.7%) stddev-sans-first:7.71 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: Values: 159.0 172.0 177.0 178.0 164.0 161.0 173.0 177.0 180.0 160.0 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:79.00 stddev:2.56 (3.2%) stddev-sans-first:1.94 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: Values: 74.0 77.0 79.0 78.0 82.0 81.0 83.0 79.0 79.0 79.0 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:20:42 INFO - 2015-11-03 13:20:42,367 DEBUG : BROWSER_OUTPUT: 13:20:43 INFO - 2015-11-03 13:20:43,111 INFO : Browser exited with error code: 0 13:20:43 INFO - 2015-11-03 13:20:43,167 INFO : Completed test kraken (00:01:01) 13:20:43 INFO - 2015-11-03 13:20:43,167 INFO : Starting test v8_7 13:20:43 INFO - 2015-11-03 13:20:43,167 DEBUG : operating with platform_type : mac_ 13:20:43 INFO - 2015-11-03 13:20:43,167 INFO : Initialising browser for v8_7 test... 13:20:43 INFO - 2015-11-03 13:20:43,182 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpqM1Shp/profile http://localhost:54517/getInfo.html 13:20:45 INFO - 2015-11-03 13:20:45,527 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:20:45 INFO - 2015-11-03 13:20:45,527 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:20:45 INFO - 2015-11-03 13:20:45,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:20:45 INFO - 2015-11-03 13:20:45,529 DEBUG : BROWSER_OUTPUT: __metrics 13:20:45 INFO - 2015-11-03 13:20:45,550 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:20:46 INFO - 2015-11-03 13:20:46,310 INFO : Browser initialized. 13:20:46 INFO - 2015-11-03 13:20:46,310 INFO : Running cycle 1/1 for v8_7 test... 13:20:46 INFO - 2015-11-03 13:20:46,311 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/T/tmpqM1Shp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:20:58 INFO - 2015-11-03 13:20:58,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 222318592 13:20:58 INFO - 2015-11-03 13:20:58,325 DEBUG : BROWSER_OUTPUT: 13:21:20 INFO - 2015-11-03 13:21:20,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54517/tests/v8_7/run.html (next: http://localhost:54517/tests/v8_7/run.html) 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 683732992 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: |0;Richards;185.7700167193015 13:21:21 INFO - 2015-11-03 13:21:21,205 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;226.39800769753225 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |2;Encrypt;358.6800573888092 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6756.756756756757 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2338.785046728972 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |5;Earley;1020.4081632653061 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |6;Boyer;14267.605633802817 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |7;RegExp;32887.096774193546 13:21:21 INFO - 2015-11-03 13:21:21,206 DEBUG : BROWSER_OUTPUT: |8;Splay;711.2676056338029 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6490.322580645161 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: __startTimestamp1446585681200__endTimestamp 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,207 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.77 Median:185.77 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: Values: 185.8 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:226.40 Median:226.40 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: Values: 226.4 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:358.68 Median:358.68 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,208 DEBUG : BROWSER_OUTPUT: Values: 358.7 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6756.76 Median:6756.76 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: Values: 6756.8 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2338.79 Median:2338.79 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: Values: 2338.8 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1020.41 Median:1020.41 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: Values: 1020.4 13:21:21 INFO - 2015-11-03 13:21:21,209 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14267.61 Median:14267.61 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: Values: 14267.6 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32887.10 Median:32887.10 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: Values: 32887.1 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:711.27 Median:711.27 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,210 DEBUG : BROWSER_OUTPUT: Values: 711.3 13:21:21 INFO - 2015-11-03 13:21:21,211 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,211 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6490.32 Median:6490.32 stddev:0.00 (0.0%) 13:21:21 INFO - 2015-11-03 13:21:21,211 DEBUG : BROWSER_OUTPUT: Values: 6490.3 13:21:21 INFO - 2015-11-03 13:21:21,211 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:21:21 INFO - 2015-11-03 13:21:21,211 DEBUG : BROWSER_OUTPUT: 13:21:21 INFO - 2015-11-03 13:21:21,901 INFO : Browser exited with error code: 0 13:21:21 INFO - 2015-11-03 13:21:21,925 INFO : Completed test v8_7 (00:00:38) 13:21:22 INFO - 2015-11-03 13:21:22,200 INFO : Completed test suite (00:20:15) 13:21:22 INFO - 2015-11-03 13:21:22,200 DEBUG : Working with test: dromaeo_css 13:21:22 INFO - 2015-11-03 13:21:22,200 DEBUG : Generating results file: dromaeo_css 13:21:22 INFO - 2015-11-03 13:21:22,201 DEBUG : Working with test: kraken 13:21:22 INFO - 2015-11-03 13:21:22,201 DEBUG : Generating results file: kraken 13:21:22 INFO - 2015-11-03 13:21:22,201 INFO : javascript benchmark 13:21:22 INFO - 2015-11-03 13:21:22,201 DEBUG : Working with test: v8_7 13:21:22 INFO - 2015-11-03 13:21:22,201 DEBUG : Generating results file: v8_7 13:21:22 INFO - 2015-11-03 13:21:22,201 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:22 INFO - 2015-11-03 13:21:22,262 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 13:21:22 INFO - 2015-11-03 13:21:22,262 DEBUG : process_Request line: dromaeo_css 5917.35 graph.html#tests=[[72,63,55]] 13:21:22 INFO - 2015-11-03 13:21:22,262 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:22 INFO - 2015-11-03 13:21:22,305 DEBUG : process_Request line: kraken 1719.90 graph.html#tests=[[232,63,55]] 13:21:22 INFO - 2015-11-03 13:21:22,305 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:22 INFO - 2015-11-03 13:21:22,340 DEBUG : process_Request line: v8_7 16129.73 graph.html#tests=[[230,63,55]] 13:21:22 INFO - 2015-11-03 13:21:22,341 INFO : javascript benchmark 13:21:22 INFO - 2015-11-03 13:21:22,343 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [293.3502292422284, 294.929216987923, 299.89653569518515, 300.7263390314814, 301.8943369820563, 12809.359532023385, 13320.40058197381, 15176.544703658894, 15430.305636246369, 15886.364545418184, 13430.731385372286, 15580.766288505652, 16374.918125409386, 16652.75020874685, 16871.578210544743, 4625.121226966882, 4631.39791827062, 4643.8142474300985, 4685.5548722871445, 4695.577398034176, 3379.8648054077808, 3513.4729790531496, 3555.1645363339594, 4743.833965811197, 4854.223324268118, 5087.898242035157, 5222.138347172712, 5243.554297884665, 5304.283921670583, 5312.123499622577, 5145.794168233266, 5213.817516386946, 5247.134222853225, 5264.263003179558, 5275.577953763709, 4475.820967161309, 4497.505274419811, 4500.819967201308, 4555.08898220354, 4561.019380833103, 19054.42836714901, 19230.230790768353, 19321.51696207592, 19383.03084845752, 19385.41843744676, 1879.6898511745546, 1941.9611607767765, 2116.661334186538, 2188.1684959715208, 2227.3652009177467, 11540.192186546945, 11750.23623464472, 11900.0, 12047.879521204852, 12422.0, 1391.373881753205, 1416.157386355117, 1447.0955652717053, 1472.9410823567046, 1482.621931407495, 49580.75209623965, 50613.987720245386, 50664.746676266754, 50871.23693144606, 52418.737906310605, 8493.787655308543, 8607.450658881336, 8829.16122968317, 8855.690050848189, 8883.156100170474, 10867.565297388173, 10877.83683244752, 10884.782304353868, 11000.669979900616, 11023.06303964156, 7120.181179164359, 7231.819204519929, 7268.382187514015, 7295.92066261113, 7353.705851765976, 7416.0729908761405, 7425.925740742631, 7446.255374462618, 7467.103947526223, 7481.0, 5197.688138711689, 5277.525022747895, 5305.0, 5332.573394128461, 5334.293026231646, 1370.5066176176767, 1434.1610158057445, 1440.8847292216808, 1469.3836779542632, 1537.2851623994895, 341.26287219605535, 351.1372170634756, 828.8176601147737, 877.7630039889194, 956.6125719083782, 8943.731688049369, 9142.680006199884, 9404.38871473352, 9450.952745236367, 9605.711828645151, 363.12849162011383, 379.62796459469877, 383.9404892241707, 391.5340744514076, 392.95088113985753, 5091.719955402488, 5114.130597798308, 5119.360079990001, 5146.76839542214, 5160.509751573594, 459560.0, 460541.0, 468301.0, 478481.0, 499911.0, 60376.698116510015, 60497.0, 60660.09009864856, 61216.38783612196, 63935.36064639294, 379.508536445304, 383.2239714578002, 383.8483798899419, 385.89580813180845, 386.66167103784187, 8864.64541418336, 8872.689455869271, 8881.59693738047, 8903.376763626484, 8946.910530894607, 31040.22399440032, 31172.37655246928, 31215.0, 31286.687133128376, 31709.524357135124, 41964.790176048926, 42186.78906605447, 42266.788666056476, 42384.78807605942, 42600.360994585724, 6711.966440167768, 6841.623710695761, 6879.2432832389395, 6907.620080895599, 6926.792196234121, 10333.276670633284, 10351.844722329322, 10388.48057597102, 10610.098141658045, 10646.414447205478, 7523.623818809147, 7831.2560306770765, 7918.564478953713, 8621.180987806149, 8821.514816685143, 8205.717712914882, 8576.957115214384, 8655.826883462421, 8732.257758090633, 8750.60622272012, 8922.0, 9109.089091090838, 9244.722658320261, 9360.719178424659, 9506.572204250964, 6755.6622168892345, 6770.898436523357, 6788.321167883172, 6847.828804279933, 6934.4452443805385, 8937.374383793072, 9022.729318120468, 9062.275017998676, 9157.908420915972, 9186.173244408035], "dojo.html": [2824.661040675119, 2838.3897462045657, 2860.8140470869394, 2875.051233093081, 2918.489264378733, 4756.595689366408, 4848.63635227358, 4855.320255164271, 4859.586935110516, 4880.536349046839, 4808.639352048593, 4816.181249187629, 4859.343988561552, 4913.0910781505445, 4928.654994150411, 4522.796474158671, 4550.067236216584, 4592.586667199951, 4617.053504031683, 4667.5332466753225, 4619.976900115495, 4650.674452788307, 4706.411698537683, 4724.527547245265, 4741.976290118545, 4394.4946331172005, 4399.64802815774, 4597.839075632337, 4635.327877457767, 4648.163330600491, 4537.31940208968, 4550.977245113786, 4604.769761511944, 4623.02916387559, 4652.302154676826, 4522.5025247222775, 4534.501204867462, 4575.473820510617, 4603.355530225737, 4614.077184563067, 4692.648051396159, 4720.480747117815, 4804.231322988305, 4877.707337559757, 4885.60915126789, 5153.6907785532985, 5154.845354639367, 5172.793088276464, 5207.973960130213, 5214.296070030536, 5211.062008838408, 5232.189010703347, 5269.446708095633, 5273.841784746463, 5290.788368465257, 4631.189541830133, 4773.928391074137, 4783.832565860178, 4857.732824694675, 4861.465238823726, 5023.949760502348, 5157.918315538012, 5169.884747792276, 5174.818881339135, 5258.316418865523, 4952.678075925053, 5031.270465782441, 5048.444671086178, 5081.4918508148885, 5108.489151084936, 5007.324011258506, 5211.114110601206, 5212.957408518311, 5251.553617942518, 5263.894722105537, 5107.974460127675, 5110.897782044338, 5116.923246151311, 5150.356205474316, 5186.5850731941355, 5031.094403007421, 5039.82360617384, 5056.342675452168, 5062.620303477254, 5115.0792857285305, 3971.702122340836, 3980.283548961157, 3982.0, 3983.721139520264, 4022.3765316376007, 3526.8941931741574, 3553.378158822196, 3557.7153827693724, 3626.111602657313, 3641.417373220272, 4772.308015337757, 4796.5203479651755, 4801.879953001203, 4813.7593120344545, 4831.130396528588, 4999.975000124976, 5112.616553758483, 5159.690418574897, 5179.896402071938, 5187.766550505236, 4684.250519916797, 4712.95287047132, 4752.643551733565, 4762.452317983407, 4785.090832741768, 4512.842050528281, 4532.88667783308, 4574.611158051536, 4603.9079218415445, 4617.792199351037, 5078.822241221539, 5126.6923984561045, 5221.712805795718, 5226.059309324358, 5301.920471192935, 5160.225966105114, 5207.088759467002, 5230.529252367305, 5239.81660641891, 5293.206019097166, 5200.427952925251, 5229.947700522946, 5264.341957255343, 5267.157254839208, 5304.761285742074, 4968.652194346506, 5100.2349647553165, 5152.098382783073, 5180.197069454241, 5183.041137389444, 5168.147255702767, 5196.454372290855, 5210.53105220532, 5221.660592061504, 5257.710825904459, 5094.490550944876, 5108.540231379194, 5124.692518448905, 5129.384473863161, 5211.71335576547, 4798.808047678054, 4939.431965324034, 5062.468440813662, 5068.974655126701, 5092.108880945893, 4773.928391074206, 4876.829310974099, 4930.0, 4947.851564453073, 5005.099082165099, 5050.797968081236, 5076.7207803571155, 5077.339945807022, 5149.124648809637, 5198.402183748917, 4756.667033307635, 4809.0862736080035, 4975.626827987843, 4978.4274808397495, 5015.5987520997505], "mootools.html": [1372.382427907442, 1508.9170095644738, 1556.9688606227876, 1595.625028118392, 1600.6958677851208, 6025.7288422021, 6342.429181373675, 6387.968060159705, 6575.7040933158005, 6579.868402631956, 6386.489080873531, 6466.547341686084, 6532.771353002646, 6537.444317233041, 6632.369924857143, 1711.0247159119308, 1727.4040456042708, 1907.2943011085918, 1907.3419670213755, 1907.9427617171507, 1921.3371386871506, 1975.4370004548707, 1986.8410527157794, 1996.620642078008, 2007.3175120459114, 1875.0, 1896.0993528074123, 1914.2438736699064, 1919.9040047997614, 1947.8149575790278, 1887.7923428422862, 1922.2311075569744, 1927.5855691026356, 1944.8638595298335, 1947.9415617531427, 1873.653374125791, 1895.9810401895943, 1897.7343171955938, 1899.335232668555, 1925.9037048147536, 6470.741170353227, 6554.705038273241, 6638.435732962704, 6647.66761661915, 6654.534182607219, 4039.7576145431367, 4143.585641435832, 4176.0, 4177.749335039907, 4183.644390226835, 2512.522620702079, 2566.2814411964678, 2614.542455070355, 2619.8035147363835, 2622.6066090086447, 720.3984672798167, 736.4255880413286, 742.9665665045086, 785.1834092543804, 792.1998781230941, 8343.290820280283, 8395.454295470774, 8506.191911768434, 8516.787080323042, 8523.360747943867, 3664.1022949377575, 3702.7222958278235, 3755.9061023474087, 3766.7928263945196, 3798.2783271178387, 7316.597587132759, 7325.194228634846, 7400.074990626172, 7411.925880741232, 7412.740554080581, 4133.421321015, 4157.875263742093, 4168.458100446923, 4174.290370636999, 4177.791110444466, 3766.849326026983, 3779.981100094482, 3781.470594116826, 3817.6945844332386, 3817.7327587069194, 2904.2013446302435, 3022.576839242508, 3123.828564288392, 3153.6057992750907, 3215.485522316418, 1038.159091136182, 1046.1421634259834, 1046.9214808889365, 1049.5959055763433, 1053.7049626104704, 897.7890195803981, 898.8292224477328, 934.8550974598948, 957.5116690487902, 1186.9703257418635, 6137.355577664371, 6211.0, 6294.370562943761, 6296.590721603081, 6302.558820882586, 1012.9088382045651, 1017.5777052523268, 1029.3978022856713, 1040.7138037039724, 1059.3114475590928, 4918.5573298403315, 4971.2543118531785, 4979.203327467588, 5057.8229761958155, 5059.62052846038, 7045.964770176116, 7369.668364923591, 7396.149442814038, 7455.366293864974, 7477.252274772588, 7562.0925488941675, 7582.54504729718, 7667.808304792313, 7674.079110506775, 7679.654415551314, 6026.246719160105, 6068.302145253264, 6131.448169664752, 6171.475424588871, 6174.25908890936, 6115.510759139347, 6120.3267640558615, 6163.7842675506145, 6186.412290832363, 6202.100695399232, 6428.389303016206, 6734.595924244365, 6777.593344399352, 6925.688344024632, 6949.617771022642, 6766.560173588701, 6824.283450237654, 6883.380495755406, 6888.621125838127, 6968.024476573182, 5211.713355765318, 5344.732763361894, 5352.4915133062295, 5355.598330125178, 5361.731913404236, 5770.740316685676, 5913.46778789911, 5941.049432090845, 6195.411435913581, 6270.028145637433, 5829.854253643693, 5878.2064421302575, 5979.611325263844, 6000.729967151401, 6022.337542870193, 5597.732918167985, 5602.215689803349, 5654.378018417889, 5841.795537156179, 5875.882482350415, 5576.163575463551, 5616.1856530803625, 5647.802326918538, 5650.0, 5650.180723795109, 5367.570594352364, 5413.621046526705, 5427.674339539641, 5457.072297709319, 5467.343918729778, 5517.724113794375, 5532.0, 5546.528545073553, 5548.778048878, 5591.356993945748], "ext.html": [476.57346674726114, 482.9348038014867, 490.0762063510284, 498.7755510020489, 505.9223853192699, 28629.427411451758, 29432.41135177298, 34724.65275347249, 36291.2741745165, 36314.45528317078, 37428.625713742855, 37817.43273850894, 37915.0, 37968.620313796855, 38002.4299635505, 7300.671469783872, 8036.638351274192, 8235.0, 8327.750167494985, 8344.707935222268, 7290.380317673004, 9416.576254068548, 9480.573374198178, 9620.230381569492, 9648.0, 9751.90248097517, 9772.31593788435, 9782.608695652165, 9875.950620246924, 9886.950565247163, 7355.5586664800285, 7587.430942679322, 9440.480773557452, 9745.756356091119, 9930.05664461875, 9596.32825702201, 9650.662226822098, 9763.707088787347, 9784.070513301225, 9801.068898454636, 33637.159071023176, 34078.1480462988, 34511.0, 34528.0, 34609.0, 2567.011700495304, 2656.787457003435, 2765.477900111693, 2818.119894395078, 2996.4456575533595, 24000.159994400114, 24380.26859194227, 24720.752792472023, 24740.25779226626, 25228.621570676456, 2110.366889933014, 2118.9682154767693, 2151.3008272311563, 2282.4065742906796, 2294.5869743446174, 240534.0, 242636.0, 243738.0, 243837.0, 244787.0, 43273.56726432758, 44915.55084449179, 51536.742316288175, 51659.741701292005, 51726.22410663843, 42007.369889451686, 53437.1984420234, 53620.73189634105, 54279.0, 54449.1832622511, 13941.093828901088, 13962.441502339792, 14187.14877107377, 14228.14631122136, 14264.0, 10811.6215932442, 10825.296355736851, 10876.129909607213, 10890.346579205274, 10908.61819836302, 15869.920650396905, 16146.19269036567, 16289.266982985793, 16328.67342653164, 16411.261493232832, 7349.669264883093, 7540.245975402416, 7580.734674286374, 7609.923900760921, 7673.501222420637, 791.9326857217201, 795.5425630262622, 859.1794835931795, 867.6442658509981, 872.0, 23698.526029479315, 24025.0, 24027.159049433187, 24080.397990050038, 24417.633735493982, 967.1489089601247, 970.8301047316833, 1020.5815615597569, 1076.0530732955106, 1113.0705860606483, 12703.174293670882, 13053.216806991612, 13352.866471335163, 13411.597652070453, 13542.45830166802, 278327.0, 285949.0, 286215.0, 288191.0, 288251.0, 47955.5204447958, 48309.275360869615, 48319.27521087186, 48372.7581362098, 48450.27324590134, 1229.2685851918095, 1237.4369661803858, 1239.9814002790147, 1240.076143273249, 1255.2719422734792, 21555.353339399844, 24836.627450588618, 25108.874455627603, 25307.367315817253, 25338.239852804447, 42750.35874461948, 43285.0, 43315.78342108269, 43353.783231083646, 43356.132877341646, 238952.0, 241454.0, 242953.0, 243074.0, 244448.0, 23228.0, 23420.531589367776, 23737.762622374245, 26181.607275890496, 26427.0, 33138.83430582831, 33145.83427082849, 33168.1707957303, 33227.0, 33376.49935250924, 27782.166535003984, 28250.0, 29095.854520727262, 29899.402011960075, 30326.696733032386, 29265.268368290963, 29736.851315743283, 29824.0, 29921.102366929026, 30110.09669709912, 28680.282992925342, 29475.705242948156, 29499.410011799213, 29862.552061718656, 29873.70126298796, 25581.23256302314, 26394.472110558065, 26722.732772672804, 26980.1905942822, 27337.31656708598, 19528.707069393688, 19766.802331976498, 19930.60138797245, 20050.699239511127, 20116.698249525976], "prototype.html": [268.81854748045066, 281.4666207536717, 284.06967182477376, 285.9270885924089, 286.76915083357886, 5256.894862102756, 5293.470652934714, 5368.597355198361, 5425.782968681253, 5446.9182962255545, 5112.795488180478, 5202.4537423570455, 5276.736163191835, 5287.021900948327, 5291.391489978653, 4174.874753757392, 4177.206330797138, 4197.79011049447, 4215.894602634928, 4221.0291632924445, 4020.597940205985, 4070.3894415837567, 4109.938350924738, 4186.916261674764, 4222.429971953793, 4048.0, 4114.465119534456, 4174.70777045607, 4188.078622703016, 4192.811323490435, 4124.6906482013665, 4167.416561681367, 4170.124273902454, 4173.707840451169, 4178.561251068655, 3582.8566857325677, 3589.10272431892, 3627.0, 3634.691051260646, 3635.2366003139373, 4964.0, 5108.463611320833, 5161.458046905096, 5172.172452407597, 5174.7412629368755, 4620.075984803019, 4626.745528995903, 4663.207254766698, 4664.95335046652, 4667.719936803769, 5623.746931388097, 5627.493525582676, 5636.74634641438, 5638.04153293941, 5643.351014633328, 3874.5156855393075, 3894.6689531389866, 3919.510061242345, 3921.3333733265413, 3922.666573341269, 5388.326459192601, 5571.220029195916, 5650.51970582501, 5823.5341172706085, 5874.853128671774, 3771.660550550409, 3814.504114465102, 3863.613638636114, 3871.787051712183, 3937.547182074098, 3960.108975480494, 3963.504561929759, 3978.622030907059, 3987.222491614107, 4001.1797581495725, 4537.22867112585, 4543.363929049936, 4546.840860569864, 4568.406107206042, 4572.542745725401, 5479.808206712746, 5543.1408131739645, 5554.91667624986, 5628.774849005994, 5636.323641163087, 1336.8663133686748, 1393.171063217384, 1396.6578188343922, 1399.7060617270488, 1408.2254759882023, 892.7455675132686, 896.3635818568758, 902.1609902790468, 906.4833045164324, 920.1948295241664, 5187.481251874782, 5200.5059519345605, 5206.140986737221, 5275.340582427197, 5276.551493123127, 5651.745671444794, 5696.11710184922, 5763.567732420085, 5768.4808367246305, 5783.508401785811, 5191.870203244874, 5233.607479439057, 5249.055170069424, 5317.946820531823, 5326.92009619856, 3157.2422618571377, 3183.1405520509334, 3239.9838000809846, 3241.62721287055, 3245.724113450336, 5822.883542329129, 5828.6502809831545, 5874.647521148745, 5882.441168089024, 5926.0, 5763.452472015152, 5962.07587823888, 5978.372270911578, 5980.820575382745, 5990.9700451497465, 5914.852128696817, 5960.284765827955, 5962.0, 5964.552658550626, 5967.940320596826, 5878.382769809279, 5914.645121292736, 5927.051671732502, 5929.199558059607, 5932.911006334994, 5611.438856114356, 5708.343540492897, 5810.01229790945, 5819.243498345188, 5830.912536312044, 5936.910946335722, 5945.762169513344, 5945.851353716019, 5969.044952807703, 5996.37038110992, 3859.671927886161, 3868.2070175613367, 3892.4161375793856, 3897.162110146332, 3916.569177390542, 5785.56608254391, 5797.188393624811, 5885.323187833454, 5888.440598143169, 5912.113183022409, 5493.423190565093, 5695.601307908407, 5699.601027928005, 5732.226149469935, 5740.339860916049, 5675.971620141873, 5695.401982791747, 5709.65742055478, 5737.282839645044, 5754.683492407958, 5524.364698059774, 5529.225908372911, 5595.944040559542, 5595.944040559705, 5597.412271711574, 5559.388467268678, 5666.801661941977, 5673.8865222694485, 5690.4878560928055, 5754.309482862083, 5519.199716041232, 5576.10782274834, 5576.33084029919, 5577.051901176891, 5594.776208951596], "yui.html": [636.8121404185765, 663.6117871045439, 675.324675324675, 679.3647939176867, 687.840987935329, 12095.395230238486, 12269.509219631203, 12347.0, 12351.0, 12483.375831208426, 11423.942880285587, 11596.0, 11606.129540284492, 11699.29804211748, 11712.882871171285, 621.8694074244414, 624.4036944717784, 803.4536515169682, 805.7139715401037, 816.5957850863831, 816.6570040582969, 822.3873214455239, 830.5390508267939, 831.7255305749119, 839.2488722593275, 851.5997481183833, 856.824351008045, 863.0592654007131, 864.1229152410309, 865.1564724393697, 630.0423356498143, 638.450932198309, 831.3806214370333, 847.449158047268, 852.3394369363731, 622.0420552349376, 627.4541149200179, 627.6704730016733, 630.2342653675806, 632.0834789555117, 10896.40069796161, 11040.944795276053, 11063.280886742417, 11174.497147628295, 11187.944060279728, 9933.75165620858, 10304.381737095724, 10427.113695335906, 10806.18953578477, 10860.076893464066, 8550.70072547464, 8597.4841509509, 8696.652133914637, 8698.913010869937, 9053.321000924958, 2678.6919504257066, 2688.193541937411, 2689.3007817967273, 2740.4930087933794, 2747.7114902935305, 40922.590774092176, 41333.1733365331, 41513.79243103795, 41927.161456771, 41993.1601367974, 5820.563457740602, 5852.882942341129, 5909.8227053188475, 6008.4592386684535, 6022.849428764316, 10325.48372581368, 10327.74180645475, 10429.843552346721, 10449.84325235122, 10460.843087353696, 5341.0653135701095, 5498.642588231752, 5584.246126772834, 5615.9157612635845, 5637.633553819071, 3215.0, 3225.5000474926424, 3346.54821599081, 3516.033090900023, 3583.0684022153905, 2380.5714971304983, 2380.73811880693, 2388.0328466970905, 2407.5064611754897, 2421.418859473714, 358.4336747938251, 362.3333067156445, 363.8926516677586, 365.51204142469567, 367.8216065208372, 372.8154563491035, 377.95464544254867, 423.9152169566099, 437.4073130907638, 447.679908865163, 6550.508711846631, 6596.571222870498, 6607.4383677386995, 6611.603303801788, 6729.024291477708, 392.0571026680837, 481.33575665581975, 508.6134537751262, 518.2948100748571, 522.8954209158107, 3133.937321253562, 3198.1844629619764, 3272.296456261915, 3592.7485076044427, 3713.2573485302505, 49705.0, 50533.0, 50705.746471267405, 50712.0, 50793.238101428506, 43293.35059974103, 43599.0, 44399.11201776011, 44659.33011004837, 44889.77555112204, 39169.608303917164, 39291.0, 40405.79797100995, 40875.386869196984, 41052.9999999994, 6451.483881289391, 6846.178458585002, 6863.38229559342, 7015.649217539205, 7015.719371225094, 31537.8423107883, 31706.0, 31957.520637189995, 32751.508727368633, 32764.344713106082, 42202.0, 42219.0, 42655.0, 42849.35725964051, 42983.570164297955, 6187.907181392373, 6351.301356850835, 6821.761238356832, 7030.718771249093, 7091.1490621125795, 9782.80434391294, 9791.0, 9933.552990115317, 10474.738131546468, 10491.213159013258, 8717.389782715149, 9153.450792952444, 9159.725208243763, 9386.45123554606, 9556.90443095588, 9102.544872756469, 9270.721878343391, 9510.008694522407, 9541.045895410403, 9821.85267220978, 8902.109789021046, 9200.95399522998, 9471.431714097176, 9491.620335186515, 9869.851952220866, 7611.124720657195, 7735.535867847947, 7814.609269536614, 7897.956656346749, 8333.83332333362, 7205.567665940061, 7317.524360916524, 7637.121731001006, 7747.961260193663, 7833.5691536966015]}, "summary": {"suite": 5917.354353582824, "subtests": {"jquery.html": {"filtered": 6815.103367458836, "value": 6815.103367458836}, "dojo.html": {"filtered": 4786.729571126506, "value": 4786.729571126506}, "mootools.html": {"filtered": 3773.7704176129296, "value": 3773.7704176129296}, "ext.html": {"filtered": 16120.873304485494, "value": 16120.873304485494}, "prototype.html": {"filtered": 4225.799222722051, "value": 4225.799222722051}, "yui.html": {"filtered": 5118.438627401694, "value": 5118.438627401694}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0078"}, "testrun": {"date": 1446584466, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151103112132", "branch": "Mozilla-Inbound", "revision": "508d22157bcaa54efffd74be9dc183abd6919799"}}, {"talos_counters": {}, "results": {"audio-dft": [181.0, 181.0, 181.0, 193.0, 183.0, 180.0, 181.0, 182.0, 181.0, 182.0], "ai-astar": [119.0, 123.0, 123.0, 130.0, 123.0, 121.0, 121.0, 122.0, 119.0, 128.0], "imaging-gaussian-blur": [129.0, 135.0, 134.0, 135.0, 129.0, 135.0, 143.0, 130.0, 136.0, 142.0], "audio-beat-detection": [180.0, 149.0, 177.0, 186.0, 149.0, 168.0, 168.0, 148.0, 187.0, 143.0], "json-stringify-tinderbox": [71.0, 74.0, 79.0, 75.0, 74.0, 78.0, 79.0, 76.0, 75.0, 74.0], "stanford-crypto-pbkdf2": [159.0, 172.0, 177.0, 178.0, 164.0, 161.0, 173.0, 177.0, 180.0, 160.0], "json-parse-financial": [61.0, 63.0, 65.0, 65.0, 68.0, 68.0, 69.0, 78.0, 68.0, 64.0], "stanford-crypto-sha256-iterative": [74.0, 77.0, 79.0, 78.0, 82.0, 81.0, 83.0, 79.0, 79.0, 79.0], "audio-fft": [88.0, 93.0, 99.0, 142.0, 78.0, 79.0, 79.0, 79.0, 134.0, 77.0], "imaging-darkroom": [148.0, 146.0, 141.0, 141.0, 154.0, 146.0, 141.0, 141.0, 146.0, 147.0], "stanford-crypto-ccm": [145.0, 147.0, 146.0, 147.0, 157.0, 145.0, 141.0, 148.0, 149.0, 143.0], "audio-oscillator": [112.0, 113.0, 159.0, 104.0, 104.0, 108.0, 145.0, 100.0, 99.0, 151.0], "stanford-crypto-aes": [96.0, 100.0, 101.0, 100.0, 101.0, 96.0, 96.0, 101.0, 101.0, 101.0], "imaging-desaturate": [118.0, 119.0, 118.0, 113.0, 117.0, 119.0, 119.0, 118.0, 113.0, 117.0]}, "summary": {"suite": 1719.8999999999999, "subtests": {"audio-fft": {"filtered": 94.8, "value": 94.8}, "stanford-crypto-pbkdf2": {"filtered": 170.1, "value": 170.1}, "audio-beat-detection": {"filtered": 165.5, "value": 165.5}, "stanford-crypto-ccm": {"filtered": 146.8, "value": 146.8}, "imaging-darkroom": {"filtered": 145.1, "value": 145.1}, "json-parse-financial": {"filtered": 66.9, "value": 66.9}, "audio-oscillator": {"filtered": 119.5, "value": 119.5}, "ai-astar": {"filtered": 122.9, "value": 122.9}, "audio-dft": {"filtered": 182.5, "value": 182.5}, "stanford-crypto-sha256-iterative": {"filtered": 79.1, "value": 79.1}, "json-stringify-tinderbox": {"filtered": 75.5, "value": 75.5}, "imaging-gaussian-blur": {"filtered": 134.8, "value": 134.8}, "stanford-crypto-aes": {"filtered": 99.3, "value": 99.3}, "imaging-desaturate": {"filtered": 117.1, "value": 117.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0078"}, "testrun": {"date": 1446584466, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151103112132", "branch": "Mozilla-Inbound", "revision": "508d22157bcaa54efffd74be9dc183abd6919799"}}, {"talos_counters": {}, "results": {"DeltaBlue": [226.39800769753225], "Encrypt": [358.6800573888092], "NavierStokes": [6490.322580645161], "Decrypt": [6756.756756756757], "Splay": [711.2676056338029], "Richards": [185.7700167193015], "RegExp": [32887.096774193546], "Earley": [1020.4081632653061], "Boyer": [14267.605633802817], "RayTrace": [2338.785046728972]}, "summary": {"suite": 16129.726894263467, "subtests": {"DeltaBlue": {"filtered": 292.0432060000001, "value": 292.0432060000001}, "Encrypt": {"filtered": 742.1126279999997, "value": 742.1126279999997}, "NavierStokes": {"filtered": 228.64811133200814, "value": 228.64811133200814}, "Decrypt": {"filtered": 39.394787999999984, "value": 39.394787999999984}, "Splay": {"filtered": 114.57150495049505, "value": 114.57150495049505}, "RegExp": {"filtered": 27.70037763609611, "value": 27.70037763609611}, "Richards": {"filtered": 190.03066599999997, "value": 190.03066599999997}, "Earley": {"filtered": 653.1337399999998, "value": 653.1337399999998}, "Boyer": {"filtered": 46.71162191510361, "value": 46.71162191510361}, "RayTrace": {"filtered": 316.3988931068931, "value": 316.3988931068931}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0078"}, "testrun": {"date": 1446584466, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151103112132", "branch": "Mozilla-Inbound", "revision": "508d22157bcaa54efffd74be9dc183abd6919799"}}] 13:21:22 INFO - RETURN: dromaeo_css: 5917.35 13:21:22 INFO - RETURN: kraken: 1719.90 13:21:22 INFO - RETURN: v8_7: 16129.73 13:21:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16129.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1719.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5917.35"}}} 13:21:22 INFO - Return code: 0 13:21:22 INFO - # TBPL SUCCESS # 13:21:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:21:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:21:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:21:22 INFO - 2015-11-03 13:21:22.448 screenresolution[2580:27469] starting screenresolution argv=screenresolution get 13:21:22 INFO - 2015-11-03 13:21:22.451 screenresolution[2580:27469] Display 0: 1600x1200x32@60 13:21:22 INFO - 2015-11-03 13:21:22.458 screenresolution[2581:27472] starting screenresolution argv=screenresolution list 13:21:22 INFO - Available Modes on Display 0 13:21:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:21:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:21:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:21:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:21:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:21:22 INFO - Intel HD Graphics 3000: 13:21:22 INFO - Chipset Model: Intel HD Graphics 3000 13:21:22 INFO - Type: GPU 13:21:22 INFO - Bus: Built-In 13:21:22 INFO - VRAM (Total): 512 MB 13:21:22 INFO - VRAM (Dynamic, Max): 10 13:21:22 INFO - Vendor: Intel (0x8086) 13:21:22 INFO - Device ID: 0x0116 13:21:22 INFO - Revision ID: 0x0009 13:21:22 INFO - Displays: 13:21:22 INFO - Display: 13:21:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:21:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:21:22 INFO - Display Serial Number: 1600x1200 60 13:21:22 INFO - Main Display: Yes 13:21:22 INFO - Mirror: Off 13:21:22 INFO - Online: Yes 13:21:22 INFO - Rotation: Supported 13:21:22 INFO - Return code: 0 13:21:22 INFO - Running post-action listener: _resource_record_post_action 13:21:22 INFO - Running post-run listener: _resource_record_post_run 13:21:23 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 32768; Write bytes: 685250560; Read time: 49; Write time: 57241 13:21:23 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 338592256; Write bytes: 334845952; Read time: 34902; Write time: 6742 13:21:23 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 24576; Write bytes: 338993152; Read time: 35; Write time: 49541 13:21:23 INFO - Running post-run listener: _upload_blobber_files 13:21:23 INFO - Blob upload gear active. 13:21:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:21:23 INFO - Copying logs to upload dir... 13:21:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.629729 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-03 13:21:23.890807) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-03 13:21:23.896219) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010171 build_url: 'https://queue.taskcluster.net/v1/task/K5rBi2q-Tvyta2_RTWMTYg/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-03 13:21:23.930037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 13:21:23.930457) ========= 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.k3a4305uPp/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.HKYCqRn3uG/Listeners TMPDIR=/var/folders/cw/nv2jcr7511s9640q0ws208vm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005702 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 13:21:23.980940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 13:21:23.981370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 13:21:23.981809) ========= ========= Total master_lag: 0.36 =========