builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0023 starttime: 1446816551.4 results: success (0) buildid: 20151106033934 builduid: 659722631453418ca6d968cf91d29590 revision: 7964a5a4b0bd914d82822c9b1bb38dea19f90232 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.401502) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.402032) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.402405) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.006417 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.427928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.428382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.446640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.446985) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.005703 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.497333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.497930) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.498626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.499174) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-06 05:29:11-- 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% 7.34M=0.002s 2015-11-06 05:29:11 (7.34 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.715152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.715644) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.021165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:11.766219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 05:29:11.766757) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7964a5a4b0bd914d82822c9b1bb38dea19f90232 --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 7964a5a4b0bd914d82822c9b1bb38dea19f90232 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-06 05:29:11,847 truncating revision to first 12 chars 2015-11-06 05:29:11,847 Setting DEBUG logging. 2015-11-06 05:29:11,848 attempt 1/10 2015-11-06 05:29:11,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7964a5a4b0bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 05:29:12,970 unpacking tar archive at: mozilla-inbound-7964a5a4b0bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.402170 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 05:29:13.380138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:13.380500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:13.467426) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:13.468053) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:29:13.468822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-06 05:29:13.469174) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:13 INFO - MultiFileLogger online at 20151106 05:29:13 in /builds/slave/test 05:29:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:29:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:13 INFO - {'append_to_log': False, 05:29:13 INFO - 'base_work_dir': '/builds/slave/test', 05:29:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:29:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:13 INFO - 'branch': 'Mozilla-Inbound', 05:29:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:13 INFO - 'config_files': ('talos/mac_config.py',), 05:29:13 INFO - 'default_actions': ('clobber', 05:29:13 INFO - 'read-buildbot-config', 05:29:13 INFO - 'download-and-extract', 05:29:13 INFO - 'populate-webroot', 05:29:13 INFO - 'create-virtualenv', 05:29:13 INFO - 'install', 05:29:13 INFO - 'run-tests'), 05:29:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:13 INFO - 'download_minidump_stackwalk': True, 05:29:13 INFO - 'download_symbols': 'ondemand', 05:29:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:13 INFO - 'installer_path': 'installer.exe', 05:29:13 INFO - 'log_level': 'info', 05:29:13 INFO - 'log_name': 'talos', 05:29:13 INFO - 'log_to_console': True, 05:29:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:13 INFO - 'opt_config_files': (), 05:29:13 INFO - 'pip_index': False, 05:29:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:13 INFO - 'cmd': ('bash', 05:29:13 INFO - '-c', 05:29:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:13 INFO - 'enabled': True, 05:29:13 INFO - 'halt_on_failure': False, 05:29:13 INFO - 'name': 'check_screen_resolution'},), 05:29:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:13 INFO - 'cmd': ('bash', 05:29:13 INFO - '-c', 05:29:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:13 INFO - 'enabled': True, 05:29:13 INFO - 'halt_on_failure': False, 05:29:13 INFO - 'name': 'check_screen_resolution'},), 05:29:13 INFO - 'run_cmd_checks_enabled': True, 05:29:13 INFO - 'sps_profile': False, 05:29:13 INFO - 'sps_profile_interval': 0, 05:29:13 INFO - 'suite': 'dromaeojs-e10s', 05:29:13 INFO - 'system_bits': '64', 05:29:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:13 INFO - 'title': 't-yosemite-r5-0023', 05:29:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:13 INFO - 'use_talos_json': True, 05:29:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:13 INFO - 'work_dir': 'build'} 05:29:13 INFO - ##### 05:29:13 INFO - ##### Running clobber step. 05:29:13 INFO - ##### 05:29:13 INFO - Running pre-action listener: _resource_record_pre_action 05:29:13 INFO - Running main action method: clobber 05:29:13 INFO - rmtree: /builds/slave/test/build 05:29:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:15 INFO - Running post-action listener: _resource_record_post_action 05:29:15 INFO - ##### 05:29:15 INFO - ##### Running read-buildbot-config step. 05:29:15 INFO - ##### 05:29:15 INFO - Running pre-action listener: _resource_record_pre_action 05:29:15 INFO - Running main action method: read_buildbot_config 05:29:15 INFO - Using buildbot properties: 05:29:15 INFO - { 05:29:15 INFO - "properties": { 05:29:15 INFO - "buildnumber": 82, 05:29:15 INFO - "product": "firefox", 05:29:15 INFO - "script_repo_revision": "production", 05:29:15 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 05:29:15 INFO - "repository": "", 05:29:15 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 05:29:15 INFO - "buildid": "20151106033934", 05:29:15 INFO - "slavename": "t-yosemite-r5-0023", 05:29:15 INFO - "pgo_build": "False", 05:29:15 INFO - "basedir": "/builds/slave/test", 05:29:15 INFO - "project": "", 05:29:15 INFO - "platform": "yosemite", 05:29:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:29:15 INFO - "slavebuilddir": "test", 05:29:15 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 05:29:15 INFO - "branch": "mozilla-inbound", 05:29:15 INFO - "repo_path": "integration/mozilla-inbound", 05:29:15 INFO - "stage_platform": "macosx64", 05:29:15 INFO - "builduid": "659722631453418ca6d968cf91d29590", 05:29:15 INFO - "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232" 05:29:15 INFO - }, 05:29:15 INFO - "sourcestamp": { 05:29:15 INFO - "repository": "", 05:29:15 INFO - "hasPatch": false, 05:29:15 INFO - "project": "", 05:29:15 INFO - "branch": "mozilla-inbound-macosx64-talos", 05:29:15 INFO - "changes": [ 05:29:15 INFO - { 05:29:15 INFO - "category": null, 05:29:15 INFO - "files": [ 05:29:15 INFO - { 05:29:15 INFO - "url": null, 05:29:15 INFO - "name": "https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:29:15 INFO - } 05:29:15 INFO - ], 05:29:15 INFO - "repository": "", 05:29:15 INFO - "rev": "7964a5a4b0bd914d82822c9b1bb38dea19f90232", 05:29:15 INFO - "who": "cbook@mozilla.com", 05:29:15 INFO - "when": 1446815111, 05:29:15 INFO - "number": 6630116, 05:29:15 INFO - "comments": "Bug 1181220 - p2: Check if MIME types are valid - r=rillian", 05:29:15 INFO - "project": "", 05:29:15 INFO - "at": "Fri 06 Nov 2015 05:05:11", 05:29:15 INFO - "branch": "mozilla-inbound-macosx64-talos", 05:29:15 INFO - "revlink": "", 05:29:15 INFO - "properties": [ 05:29:15 INFO - [ 05:29:15 INFO - "buildid", 05:29:15 INFO - "20151106033934", 05:29:15 INFO - "Change" 05:29:15 INFO - ], 05:29:15 INFO - [ 05:29:15 INFO - "builduid", 05:29:15 INFO - "659722631453418ca6d968cf91d29590", 05:29:15 INFO - "Change" 05:29:15 INFO - ], 05:29:15 INFO - [ 05:29:15 INFO - "pgo_build", 05:29:15 INFO - "False", 05:29:15 INFO - "Change" 05:29:15 INFO - ] 05:29:15 INFO - ], 05:29:15 INFO - "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232" 05:29:15 INFO - } 05:29:15 INFO - ], 05:29:15 INFO - "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232" 05:29:15 INFO - } 05:29:15 INFO - } 05:29:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:29:15 INFO - Running post-action listener: _resource_record_post_action 05:29:15 INFO - ##### 05:29:15 INFO - ##### Running download-and-extract step. 05:29:15 INFO - ##### 05:29:15 INFO - Running pre-action listener: _resource_record_pre_action 05:29:15 INFO - Running main action method: download_and_extract 05:29:15 INFO - mkdir: /builds/slave/test/build/tests 05:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:15 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/test_packages.json 05:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/test_packages.json 05:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:29:17 INFO - Downloaded 1149 bytes. 05:29:17 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:29:17 INFO - Using the following test package requirements: 05:29:17 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:17 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:29:17 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'jsshell-mac.zip'], 05:29:17 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:29:17 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:17 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:29:17 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:29:17 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:29:17 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:17 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:17 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:29:17 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:29:17 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')]} 05:29:17 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:19 INFO - Downloaded 17455851 bytes. 05:29:19 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 05:29:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:24 INFO - Return code: 0 05:29:24 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 05:29: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')]} 05:29:24 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:25 INFO - Downloaded 17455851 bytes. 05:29:25 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 05:29:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:31 INFO - Return code: 0 05:29: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')]} 05:29:31 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:29:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:33 INFO - Downloaded 11131623 bytes. 05:29:33 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 05:29:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:29:33 INFO - Return code: 0 05:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:33 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:38 INFO - Downloaded 108688545 bytes. 05:29:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:38 INFO - mkdir: /builds/slave/test/properties 05:29:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:38 INFO - Contents: 05:29:38 INFO - build_url:https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:38 INFO - Running post-action listener: _resource_record_post_action 05:29:38 INFO - Running post-action listener: set_extra_try_arguments 05:29:38 INFO - ##### 05:29:38 INFO - ##### Running populate-webroot step. 05:29:38 INFO - ##### 05:29:38 INFO - Running pre-action listener: _resource_record_pre_action 05:29:38 INFO - Running main action method: populate_webroot 05:29:38 INFO - Guessing talos json url... 05:29:38 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')]} 05:29:38 INFO - https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:29:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:29:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:29:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS_mO155Tne8g4qaG2O8GQ/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 05:29:38 INFO - Downloaded 111 bytes. 05:29:38 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:29:38 INFO - Contents: 05:29:38 INFO - 20151106033934 05:29:38 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/7964a5a4b0bd914d82822c9b1bb38dea19f90232 05:29:38 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')]} 05:29:38 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7964a5a4b0/testing/talos/talos.json 05:29:38 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7964a5a4b0/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7964a5a4b0/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:29:39 INFO - Downloaded 4264 bytes. 05:29:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:29:39 INFO - '../fennec_ids.txt'], 05:29:39 INFO - 'tests': ['tcheck2']}, 05:29:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:39 INFO - '--tppagecycles', 05:29:39 INFO - '7'], 05:29:39 INFO - 'tests': ['tsvgm']}}, 05:29:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['damp', 'tps']}, 05:29:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['damp', 'tps']}, 05:29:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:39 INFO - 'other': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other_l64': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'svgr': {'tests': ['tsvgx', 05:29:39 INFO - 'tsvgr_opacity', 05:29:39 INFO - 'tart', 05:29:39 INFO - 'tscrollx', 05:29:39 INFO - 'cart']}, 05:29:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tsvgx', 05:29:39 INFO - 'tsvgr_opacity', 05:29:39 INFO - 'tart', 05:29:39 INFO - 'tscrollx', 05:29:39 INFO - 'cart']}, 05:29:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['tp5o']}, 05:29:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tp5o']}, 05:29:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--xperf_path', 05:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:39 INFO - 'tests': ['tp5n']}, 05:29:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s', 05:29:39 INFO - '--xperf_path', 05:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:29:39 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:29:39 INFO - 'tests': ['tp5n']}}, 05:29:39 INFO - 'talos.zip': {'path': '', 05:29:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:39 INFO - Running post-action listener: _resource_record_post_action 05:29:39 INFO - ##### 05:29:39 INFO - ##### Running create-virtualenv step. 05:29:39 INFO - ##### 05:29:39 INFO - Running pre-action listener: _resource_record_pre_action 05:29:39 INFO - Running main action method: create_virtualenv 05:29:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:39 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 05:29:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:39 INFO - Using real prefix '/tools/python27' 05:29:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:44 INFO - Installing pip.................done. 05:29:44 INFO - Return code: 0 05:29:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:44 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 05:29:44 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 05:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:44 INFO - 'HOME': '/Users/cltbld', 05:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:44 INFO - 'LOGNAME': 'cltbld', 05:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:44 INFO - 'MOZ_NO_REMOTE': '1', 05:29:44 INFO - 'NO_EM_RESTART': '1', 05:29:44 INFO - 'PAGER': '/bin/cat', 05:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:44 INFO - 'PWD': '/builds/slave/test', 05:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:44 INFO - 'SHELL': '/bin/bash', 05:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:29:44 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:44 INFO - 'USER': 'cltbld', 05:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:44 INFO - 'XPC_FLAGS': '0x0', 05:29:44 INFO - 'XPC_SERVICE_NAME': '0', 05:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:44 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 05:29:44 INFO - Cleaning up... 05:29:44 INFO - Return code: 0 05:29:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:44 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 05:29:44 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 05:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:44 INFO - 'HOME': '/Users/cltbld', 05:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:44 INFO - 'LOGNAME': 'cltbld', 05:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:44 INFO - 'MOZ_NO_REMOTE': '1', 05:29:44 INFO - 'NO_EM_RESTART': '1', 05:29:44 INFO - 'PAGER': '/bin/cat', 05:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:44 INFO - 'PWD': '/builds/slave/test', 05:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:44 INFO - 'SHELL': '/bin/bash', 05:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:29:44 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:44 INFO - 'USER': 'cltbld', 05:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:44 INFO - 'XPC_FLAGS': '0x0', 05:29:44 INFO - 'XPC_SERVICE_NAME': '0', 05:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:45 INFO - Downloading/unpacking psutil>=0.7.1 05:29:45 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 05:29:45 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 05:29:45 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 05:29:45 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 05:29:45 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 05:29:45 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 05:29:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:29:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:48 INFO - Installing collected packages: psutil 05:29:48 INFO - Running setup.py install for psutil 05:29:48 INFO - building 'psutil._psutil_osx' extension 05:29:48 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 05:29:48 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 05:29:48 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 05:29:48 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 05:29:48 INFO - building 'psutil._psutil_posix' extension 05:29:48 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 05:29:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:29:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:29:48 INFO - ^ 05:29:49 INFO - 1 warning generated. 05:29:49 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 05:29:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:49 INFO - Successfully installed psutil 05:29:49 INFO - Cleaning up... 05:29:49 INFO - Return code: 0 05:29:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:49 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 05:29:49 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 05:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:49 INFO - 'HOME': '/Users/cltbld', 05:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:49 INFO - 'LOGNAME': 'cltbld', 05:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:49 INFO - 'MOZ_NO_REMOTE': '1', 05:29:49 INFO - 'NO_EM_RESTART': '1', 05:29:49 INFO - 'PAGER': '/bin/cat', 05:29:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:49 INFO - 'PWD': '/builds/slave/test', 05:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:49 INFO - 'SHELL': '/bin/bash', 05:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:29:49 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:49 INFO - 'USER': 'cltbld', 05:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:49 INFO - 'XPC_FLAGS': '0x0', 05:29:49 INFO - 'XPC_SERVICE_NAME': '0', 05:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:49 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 05:29:49 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 05:29:49 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 05:29:49 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 05:29:49 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 05:29:49 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 05:29:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:29:52 INFO - Installing collected packages: mozsystemmonitor 05:29:52 INFO - Running setup.py install for mozsystemmonitor 05:29:52 INFO - Successfully installed mozsystemmonitor 05:29:52 INFO - Cleaning up... 05:29:52 INFO - Return code: 0 05:29:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:52 INFO - 'HOME': '/Users/cltbld', 05:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:52 INFO - 'LOGNAME': 'cltbld', 05:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:52 INFO - 'MOZ_NO_REMOTE': '1', 05:29:52 INFO - 'NO_EM_RESTART': '1', 05:29:52 INFO - 'PAGER': '/bin/cat', 05:29:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:52 INFO - 'PWD': '/builds/slave/test', 05:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:52 INFO - 'SHELL': '/bin/bash', 05:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:29:52 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:52 INFO - 'USER': 'cltbld', 05:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:52 INFO - 'XPC_FLAGS': '0x0', 05:29:52 INFO - 'XPC_SERVICE_NAME': '0', 05:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:52 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 05:29:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:55 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 05:29:55 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 05:29:55 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 05:29:55 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 05:29:55 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 05:29:55 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 05:29:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:56 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 05:29:56 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 05:29:56 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 05:29:56 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 05:29:56 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 05:29:56 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 05:29:56 INFO - Downloading docopt-0.6.1.tar.gz 05:29:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:57 INFO - Running setup.py install for blobuploader 05:29:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:57 INFO - Running setup.py install for requests 05:29:57 INFO - Running setup.py install for docopt 05:29:58 INFO - Successfully installed blobuploader requests docopt 05:29:58 INFO - Cleaning up... 05:29:58 INFO - Return code: 0 05:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:58 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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:29:58 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 05:29:58 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 05:29:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:29:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:58 INFO - 'HOME': '/Users/cltbld', 05:29:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:58 INFO - 'LOGNAME': 'cltbld', 05:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:58 INFO - 'MOZ_NO_REMOTE': '1', 05:29:58 INFO - 'NO_EM_RESTART': '1', 05:29:58 INFO - 'PAGER': '/bin/cat', 05:29:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:58 INFO - 'PWD': '/builds/slave/test', 05:29:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:58 INFO - 'SHELL': '/bin/bash', 05:29:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:29:58 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:29:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:58 INFO - 'USER': 'cltbld', 05:29:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:58 INFO - 'XPC_FLAGS': '0x0', 05:29:58 INFO - 'XPC_SERVICE_NAME': '0', 05:29:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:58 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-qQAO9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:58 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-PX7WG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:58 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-VSZFQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-i3Af75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-t3s5FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-dZ09q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-gcBVco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-weKDqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-H3koh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-jHB7ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:59 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-rK_SM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-DQr5O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-S7YBzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-cQVXTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-SEoEvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-5PdmAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:00 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-WwJuJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:00 INFO - Running setup.py install for manifestparser 05:30:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Running setup.py install for mozcrash 05:30:01 INFO - Running setup.py install for mozdebug 05:30:01 INFO - Running setup.py install for mozdevice 05:30:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:01 INFO - Running setup.py install for mozfile 05:30:01 INFO - Running setup.py install for mozhttpd 05:30:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Running setup.py install for mozinfo 05:30:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Running setup.py install for mozInstall 05:30:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Running setup.py install for mozleak 05:30:02 INFO - Running setup.py install for mozlog 05:30:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Running setup.py install for moznetwork 05:30:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:03 INFO - Running setup.py install for mozprocess 05:30:03 INFO - Running setup.py install for mozprofile 05:30:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:03 INFO - Running setup.py install for mozrunner 05:30:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:03 INFO - Running setup.py install for mozscreenshot 05:30:03 INFO - Running setup.py install for moztest 05:30:03 INFO - Running setup.py install for mozversion 05:30:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:04 INFO - Cleaning up... 05:30:04 INFO - Return code: 0 05:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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', '-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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:30:04 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 05:30:04 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 05:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:04 INFO - 'HOME': '/Users/cltbld', 05:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PAGER': '/bin/cat', 05:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:30:04 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - 'XPC_FLAGS': '0x0', 05:30:04 INFO - 'XPC_SERVICE_NAME': '0', 05:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:04 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-H5I3SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:04 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)) 05:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:04 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-ACGOT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:04 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)) 05:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:04 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-KiYs0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:04 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)) 05:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:04 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-PSP6A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Gt4Bhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-d3AVnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-gw8XuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-SP9biP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-5KXvzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-KJyKi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:05 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)) 05:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:05 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-SXXZle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-dJqyXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-JmxxWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-AGsrGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-4DEfQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-t7x_fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:06 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)) 05:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:06 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-zV0yzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 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)) 05:30:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:06 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 05:30:06 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 05:30:06 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 05:30:06 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 05:30:06 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 05:30:06 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 05:30:09 INFO - Downloading blessings-1.5.1.tar.gz 05:30:09 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 05:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:09 INFO - Installing collected packages: blessings 05:30:09 INFO - Running setup.py install for blessings 05:30:09 INFO - Successfully installed blessings 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:10 INFO - Reading from file tmpfile_stdout 05:30:10 INFO - Current package versions: 05:30:10 INFO - blessings == 1.5.1 05:30:10 INFO - blobuploader == 1.2.4 05:30:10 INFO - docopt == 0.6.1 05:30:10 INFO - manifestparser == 1.1 05:30:10 INFO - mozInstall == 1.12 05:30:10 INFO - mozcrash == 0.16 05:30:10 INFO - mozdebug == 0.1 05:30:10 INFO - mozdevice == 0.47 05:30:10 INFO - mozfile == 1.2 05:30:10 INFO - mozhttpd == 0.7 05:30:10 INFO - mozinfo == 0.9 05:30:10 INFO - mozleak == 0.1 05:30:10 INFO - mozlog == 3.0 05:30:10 INFO - moznetwork == 0.27 05:30:10 INFO - mozprocess == 0.22 05:30:10 INFO - mozprofile == 0.27 05:30:10 INFO - mozrunner == 6.11 05:30:10 INFO - mozscreenshot == 0.1 05:30:10 INFO - mozsystemmonitor == 0.0 05:30:10 INFO - moztest == 0.7 05:30:10 INFO - mozversion == 1.4 05:30:10 INFO - psutil == 3.1.1 05:30:10 INFO - requests == 1.2.3 05:30:10 INFO - wsgiref == 0.1.2 05:30:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:10 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 0x10c013a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c080228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f854ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, '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.AgsxWkDhOl/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.TNBrw5qf94/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 05:30:10 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 05:30:10 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 05:30:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:30:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:10 INFO - 'HOME': '/Users/cltbld', 05:30:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:10 INFO - 'LOGNAME': 'cltbld', 05:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:10 INFO - 'MOZ_NO_REMOTE': '1', 05:30:10 INFO - 'NO_EM_RESTART': '1', 05:30:10 INFO - 'PAGER': '/bin/cat', 05:30:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:10 INFO - 'PWD': '/builds/slave/test', 05:30:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:10 INFO - 'SHELL': '/bin/bash', 05:30:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:30:10 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:30:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:10 INFO - 'USER': 'cltbld', 05:30:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:10 INFO - 'XPC_FLAGS': '0x0', 05:30:10 INFO - 'XPC_SERVICE_NAME': '0', 05:30:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 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)) 05:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:10 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)) 05:30:10 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)) 05:30:10 INFO - Cleaning up... 05:30:10 INFO - Return code: 0 05:30:10 INFO - Running post-action listener: _resource_record_post_action 05:30:10 INFO - Running post-action listener: _start_resource_monitoring 05:30:10 INFO - Starting resource monitoring. 05:30:10 INFO - ##### 05:30:10 INFO - ##### Running install step. 05:30:10 INFO - ##### 05:30:10 INFO - Running pre-action listener: _resource_record_pre_action 05:30:10 INFO - Running main action method: install 05:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:11 INFO - Reading from file tmpfile_stdout 05:30:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:11 INFO - Reading from file tmpfile_stdout 05:30:11 INFO - Output received: 05:30:11 INFO - Usage: mozinstall [options] installer 05:30:11 INFO - Options: 05:30:11 INFO - -h, --help show this help message and exit 05:30:11 INFO - -d DEST, --destination=DEST 05:30:11 INFO - Directory to install application into. [default: 05:30:11 INFO - "/builds/slave/test"] 05:30:11 INFO - --app=APP Application being installed. [default: firefox] 05:30:11 INFO - mkdir: /builds/slave/test/build/application 05:30:11 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'] 05:30:11 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 05:30:52 INFO - Reading from file tmpfile_stdout 05:30:52 INFO - Output received: 05:30:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:30:52 INFO - Running post-action listener: _resource_record_post_action 05:30:52 INFO - ##### 05:30:52 INFO - ##### Running run-tests step. 05:30:52 INFO - ##### 05:30:52 INFO - Running pre-action listener: _resource_record_pre_action 05:30:52 INFO - Running main action method: run_tests 05:30:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:52 INFO - 2015-11-06 05:30:52.485 screenresolution[1944:16249] starting screenresolution argv=screenresolution get 05:30:52 INFO - 2015-11-06 05:30:52.489 screenresolution[1944:16249] Display 0: 1600x1200x32@60 05:30:52 INFO - 2015-11-06 05:30:52.496 screenresolution[1945:16252] starting screenresolution argv=screenresolution list 05:30:52 INFO - Available Modes on Display 0 05:30:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:52 INFO - Intel HD Graphics 3000: 05:30:52 INFO - Chipset Model: Intel HD Graphics 3000 05:30:52 INFO - Type: GPU 05:30:52 INFO - Bus: Built-In 05:30:52 INFO - VRAM (Total): 512 MB 05:30:52 INFO - VRAM (Dynamic, Max): 10 05:30:52 INFO - Vendor: Intel (0x8086) 05:30:52 INFO - Device ID: 0x0116 05:30:52 INFO - Revision ID: 0x0009 05:30:52 INFO - Displays: 05:30:52 INFO - Display: 05:30:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:52 INFO - Display Serial Number: 1600x1200 60 05:30:52 INFO - Main Display: Yes 05:30:52 INFO - Mirror: Off 05:30:52 INFO - Online: Yes 05:30:52 INFO - Rotation: Supported 05:30:52 INFO - Return code: 0 05:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:52 INFO - Python 2.7.3 05:30:52 INFO - Return code: 0 05:30:52 INFO - grabbing minidump binary from tooltool 05:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:52 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 0x10bfc89f0>, '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 0x10bd27cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf92990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:52 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 05:30:52 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 05:30:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:52 INFO - Return code: 0 05:30:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:30:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:30:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:52 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] in /builds/slave/test/build 05:30:52 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0023 --webServer localhost 05:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgsxWkDhOl/Render', 05:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:52 INFO - 'HOME': '/Users/cltbld', 05:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:52 INFO - 'LOGNAME': 'cltbld', 05:30:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:52 INFO - 'MOZ_NO_REMOTE': '1', 05:30:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:52 INFO - 'NO_EM_RESTART': '1', 05:30:52 INFO - 'PAGER': '/bin/cat', 05:30:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:52 INFO - 'PWD': '/builds/slave/test', 05:30:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:52 INFO - 'SHELL': '/bin/bash', 05:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNBrw5qf94/Listeners', 05:30:52 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 05:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:52 INFO - 'USER': 'cltbld', 05:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:52 INFO - 'XPC_FLAGS': '0x0', 05:30:52 INFO - 'XPC_SERVICE_NAME': '0', 05:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:52 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] with output_timeout 3600 05:30:53 INFO - mozversion INFO | application_buildid: 20151106033934 05:30:53 INFO - mozversion INFO | application_changeset: 7964a5a4b0bd914d82822c9b1bb38dea19f90232 05:30:53 INFO - mozversion INFO | application_display_name: Nightly 05:30:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:53 INFO - mozversion INFO | application_name: Firefox 05:30:53 INFO - mozversion INFO | application_remotingname: firefox 05:30:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:30:53 INFO - mozversion INFO | application_vendor: Mozilla 05:30:53 INFO - mozversion INFO | application_version: 45.0a1 05:30:53 INFO - mozversion INFO | platform_buildid: 20151106033934 05:30:53 INFO - mozversion INFO | platform_changeset: 7964a5a4b0bd914d82822c9b1bb38dea19f90232 05:30:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:30:53 INFO - mozversion INFO | platform_version: 45.0a1 05:30:53 INFO - 2015-11-06 05:30:53,160 DEBUG : using testdate: 1446816653 05:30:53 INFO - 2015-11-06 05:30:53,160 DEBUG : actual date: 1446816653 05:30:53 INFO - 2015-11-06 05:30:53,176 INFO : starting webserver on 'localhost:51242' 05:30:53 INFO - 2015-11-06 05:30:53,177 INFO : Starting test suite t-yosemite-r5-0023.e 05:30:53 INFO - 2015-11-06 05:30:53,177 INFO : Starting test dromaeo_css 05:30:53 INFO - 2015-11-06 05:30:53,177 DEBUG : operating with platform_type : mac_ 05:30:53 INFO - 2015-11-06 05:30:53,178 INFO : Initialising browser for dromaeo_css test... 05:30:53 INFO - 2015-11-06 05:30:53,206 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpIYDoUd/profile http://localhost:51242/getInfo.html 05:30:56 INFO - 2015-11-06 05:30:56,467 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:56 INFO - 2015-11-06 05:30:56,467 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:56 INFO - 2015-11-06 05:30:56,467 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:30:56 INFO - 2015-11-06 05:30:56,467 DEBUG : BROWSER_OUTPUT: __metrics 05:30:57 INFO - 2015-11-06 05:30:57,197 INFO : Browser initialized. 05:30:57 INFO - 2015-11-06 05:30:57,198 INFO : Running cycle 1/1 for dromaeo_css test... 05:30:57 INFO - 2015-11-06 05:30:57,198 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpIYDoUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:09 INFO - 2015-11-06 05:31:09,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 233730048 05:31:09 INFO - 2015-11-06 05:31:09,367 DEBUG : BROWSER_OUTPUT: 05:31:59 INFO - 2015-11-06 05:31:59,221 DEBUG : BROWSER_OUTPUT: 1446816719220 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] 05:34:10 INFO - 2015-11-06 05:34:10,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51242/tests/dromaeo/cssquery-ext.html) 05:34:11 INFO - 2015-11-06 05:34:11,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 257589248 05:34:11 INFO - 2015-11-06 05:34:11,780 DEBUG : BROWSER_OUTPUT: 05:37:13 INFO - 2015-11-06 05:37:13,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-ext.html (next: http://localhost:51242/tests/dromaeo/cssquery-jquery.html) 05:37:14 INFO - 2015-11-06 05:37:14,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 264089600 05:37:14 INFO - 2015-11-06 05:37:14,502 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-11-06 05:40:16,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51242/tests/dromaeo/cssquery-mootools.html) 05:40:16 INFO - 2015-11-06 05:40:16,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 267227136 05:40:16 INFO - 2015-11-06 05:40:16,883 DEBUG : BROWSER_OUTPUT: 05:43:18 INFO - 2015-11-06 05:43:18,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51242/tests/dromaeo/cssquery-prototype.html) 05:43:19 INFO - 2015-11-06 05:43:19,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 271392768 05:43:19 INFO - 2015-11-06 05:43:19,219 DEBUG : BROWSER_OUTPUT: 05:46:22 INFO - 2015-11-06 05:46:22,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51242/tests/dromaeo/cssquery-yui.html) 05:46:22 INFO - 2015-11-06 05:46:22,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 277692416 05:46:22 INFO - 2015-11-06 05:46:22,703 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-yui.html (next: http://localhost:51242/tests/dromaeo/cssquery-dojo.html) 05:49:25 INFO - 2015-11-06 05:49:25,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 281759744 05:49:25 INFO - 2015-11-06 05:49:25,395 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:49:25 INFO - 2015-11-06 05:49:25,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:49:25 INFO - 2015-11-06 05:49:25,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:49:25 INFO - 2015-11-06 05:49:25,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:49:25 INFO - 2015-11-06 05:49:25,400 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.7458041486057;2729.2085295264374;2731.9863400682993;2758.572421274702;2820.534611789055;4650.23271160259;4676.134915040716;4784.2345224764;4795.784189711462;4838.588719958799;4531.592156705896;4604.6776725629215;4632.907341853161;4666.533346665332;4712.151812673717;4409.1622591707555;4430.9556904430865;4470;4494.460664720238;4520.2315606347;494.63649279338694;4149.543550209474;4359.803808828595;4420.513743488214;4496.482904465979;4237.152569486084;4318.978405107954;4324.048709283952;4352.303631418958;4434.290513517822;4320.027993701424;4387.934180987288;4398.3622374755805;4445.177642136183;4475.7985890635;4191.015111448807;4214.157168566299;4350.303951367766;4405.9118817623785;4426.911461770779;4436.268015777425;4531.5921567058795;4568.908621827578;4620.422447194101;4650.86047418578;4902.068606964701;4932.457429682732;4981.975090124526;4983.377077865267;4983.825566105169;4836.564709176191;4958;4982.327385802906;5065.569426598743;5083.288339632454;4705.55297246761;4710.576048155683;4728.71627702339;4729.763511824463;4733.881652958704;5098.821541246039;5136.563392111712;5138.794448222029;5192.81825136126;5205;4712.528747125329;4781.139394908881;4786.114568804782;4845.273209018605;4846.055019271208;4840.201366774513;4971.1549036663855;5032.572231360376;5035.0685123252315;5038.899222015539;4893.6329775266995;4909.852704418873;4915.48387419323;4968.22992436173;4980.601551875841;4886.291487734258;4887.853364399002;4952.331435256267;4982.925256121089;4989.3264409305;3854.3062248795486;3856.3829787234467;3870.7871067091583;3935.704822138351;3936.389859571771;3467.514547963287;3494.1614012636783;3518.6404164921187;3541.3448512025357;3545.8227088645463;4351.26028575143;4636.119137363958;4676.602488788491;4692.694974826625;4707.152712511781;4994.525520075587;5072.137736584789;5079.339685840817;5091.439941606421;5091.796328146833;4639.327297541905;4664.976675116603;4702.623790096784;4743.857684269477;4767.427908650984;4282.207791558571;4332.480102387671;4420.292753159479;4437.445319335083;4547.499775024745;5127.615428842777;5149.382074151126;5165.096108181053;5186.170212765939;5200.323957885526;5013.774380152829;5053.191489361684;5093.974530127474;5117.411497677815;5131.640785145004;4937.382827146606;5008.0735064011815;5092.261622064706;5223.085959956917;5244.396894357045;4814.662973591815;4825.782839772289;4906.950930490792;4923.458419573915;4931.50684931504;4780.498047704941;4876.902461950812;4985.376827896513;5026.070177017264;5073.467285935071;4665;4879.170541008109;4893.21708526634;4943.604511639132;4960.528749768766;4892.559669629751;4899.828506002273;4925.014997000542;4930.112579735682;4932.556069953722;4580.770961451981;4645.2103142465185;4663.370444990019;4668.836590719445;4817.229243321051;4721.480637129982;4883.8290659826735;4885.169521181479;4899.387576552931;4938.678985865908;4766.428028636586;4788.545088216614;4814.614830813456;4824.95175048245;4825.324454576292 05:49:25 INFO - 2015-11-06 05:49:25,401 DEBUG : BROWSER_OUTPUT: |1;ext.html;485.94168699756034;489.4884845336623;506.099143524526;506.93156423882766;521.5749164430988;33994.830025849864;35143.648563514354;35246.8237658812;35287.4706879397;35351.4697279541;36351;37876.81061594695;37905.81047094761;37919.62080379196;37922.81038594803;7727.884081738778;7871.055473343178;7985.520868747864;8001.599920004006;8018.318442932357;7797.532148071134;7854.057513098436;7959.044914610255;7963.163867793885;7966.561839098877;7713.498622589514;7926.6829326826855;7941.642626081812;7943.483673561229;7949.562774047425;7749.845003099935;7862.331701805296;7937.920620793776;7952.244536768998;7956.403269754763;7689.577073261024;7701.614919254071;7703.961480192619;7811.296983271533;7817.413693972975;34213.31573368519;34302.31395372078;34753.82623086894;34783.65216347829;34784;2171.4028642123385;2344.5310937812337;2476.2571228631336;2665.1071890916373;2712.7016028236876;23481.060757569678;23878.164264250667;23976.88011559931;24049.639255411184;24141.15505957283;1996.8502362322884;2022.4135000849735;2031.4560933690354;2032.7865574114653;2045.5602045560277;216565;217641;218632;220403;220620;50762.74618626883;51016.489835101915;51365.486345136815;51384.486155138715;51453.742731286104;61728;62158.37841621526;62915;62998.68500657468;63072.36927630665;14266.3580138894;14467.49363772263;14474.710505790035;14556.126632402089;14641.194734289504;11059.889401106047;11097;11123.944380278046;11153.888461115284;11265.324080555192;16775.15473297936;17855.464336069937;17900.373486927896;17932.641347172983;18134.90932545329;7257.927420725725;7534.736284230025;7557.4331925105835;7565.962170189114;7568.480656494757;778.3345239819986;796.6016991504248;818.7380038387658;828.2131974624131;918.7335672654855;24744.505109898062;25176.24471265865;25194;25200.117995870056;25247.873760631446;901.486152892858;961.1445813226235;980.1913421427352;985.930984831055;1016.6746641074785;12919.547815826401;13042.41309141091;13085.542006029744;13144.868551314556;13157.67105822343;252940;256860;257126;261171;261907;47243.29135062977;47859.042819143426;47866.28200576994;48385;48532;1187.4359679152506;1194.898433633151;1198.7302856857136;1204.072863894796;1208.709909621702;24314.784260787244;24353.269401917973;24425.877870611243;24715.62926556139;24843.627345590194;41785.373219401125;41813.58186418218;42304;42361.364579531946;42879.3568096485;239550;240232;240537;240812;242377;27873;36412.27175456529;37857.43213851739;37950.62049379581;38024.23951520899;34994.650053499136;35016.299674006885;35668.64331356757;40327;43075.13849722925;32929.50605740868;34902.248362491584;35094.12264693403;35186.648133518334;35740.28519429649;31147.221319467193;31518.36963260768;31769;31886.202844928135;32112.591555633888;32100.197495061875;32490.83754581212;34287.82856085704;35588.644113558534;35634.82182589071;26144.738552614992;28218.85890570534;28279.858600706866;28392.574111387934;28940.131796046153;21085;21242.468938276666;21249.787502124782;21281.148754049664;21288.25491107804 05:49:25 INFO - 2015-11-06 05:49:25,405 DEBUG : BROWSER_OUTPUT: |2;jquery.html;284.2694275711423;286.68178322062505;291;291.40407865914204;295.0852357691157;13912.373943172557;14549.490767823128;15014.474493392734;15190.164540950258;16097.275622596982;15182.240887955613;15207.771883421758;15551.755859531238;15608.219589020531;15727.449539266128;4327.610515053644;4539.909201815962;4544.886377840564;4547.317902314646;4564.8174073037035;4529.8641040768825;4584.633229341644;4601.608863246628;4605.746683932382;4654.975905300828;3383.5939687237565;4558.179527685015;4586.1974154522995;4868.634852386068;4956.752162391884;4602.010567727954;4829.7102173869325;4830.637702172316;4889.3399391082285;4901.460839307673;3211.1329940916057;3292.37444885471;4288.1638080573985;4304.268274393361;4305.9569404306185;10740.946295268552;10854.185936054748;11032.062274706659;11053.392063436508;11230.719232019183;1596.5449846793608;1605.3979757590903;1627.9987807498421;1678.261564911435;1695.4489790818034;7796.337311328544;7957.164497727771;7998.800029999238;8071.152528984489;8214.1375155609;1297.7209899871573;1326.6152815683536;1334.2994927663055;1339.163023110556;1359.8368195816468;47995.76002120002;49583.50416495825;49813.75093124547;50230;50561.24158137631;5305.787768489217;5314.601404894648;5399.217113518596;5428.077226871442;5450.5367043800925;6075.453209211192;6085.9695701521205;6158.630482171084;6167.660778657128;6170.598911070766;4472.9552704472535;4555.794989225493;4607.516210797818;4615.5845973862515;4616.376789133424;4915.336429581961;4928.728919909439;4943.90112197754;4995.975020124876;5027.296178535008;2410.529946660384;2412.915547955813;2417.9637305440433;2438.963415548733;2440.572899742538;856.8586183279814;861.2421069458961;865.3682811547606;872.1757938747949;920.3557509743073;322.81115547405034;323.5744995331132;358.89950813772185;373.0487257493381;383.844542960096;9533.380330278509;9817.214622830157;9876;9932.702018939442;9972.052654997764;384.45407521319237;389.75055964182945;392.75845355106975;392.79770917977265;414.8942019784935;4998.500149984972;5224.425313215544;5270.859463656444;5295.338082739658;5366.651167674088;472505;477253;487197;490809;495249;56102;57197.14204286856;61268;61569;64898.67550662217;408.78947342118835;415.52007431416763;419.492414178847;420.66557087115814;420.7349369896945;8701.825963480822;9037.909620903707;9223.86164207524;9261.814763704822;9418.905810942077;24450.75549244485;28668;29413.70586294195;29511.26221844385;31442.21394465157;40489.59510404858;40677.59322406738;41112;41219.58780412158;41628.79185604052;5102.770375333044;5133.8716532087;5156.922646160386;5214.634975551675;5216.191490318854;9609;9743.561539730586;9790.461524616214;9864.260180486635;9887.950560247153;8309.210624990616;8370.623321950405;8459.323254139777;8555.61499732501;8654.48073115615;1897.5540747924504;5041.437154482122;6877.724891004304;7913.208679132271;8331.666733330841;8191.590420478833;8610.741677749678;8615.655373784979;8632.266257367943;8671.132886711279;4942.75286235694;5075.0357432087785;5082.974585127051;5088.872778180576;5154.690718556899;8205.384596155192;8401.369897257853;8419.242268195892;8496.532690701824;8502.277306428776 05:49:25 INFO - 2015-11-06 05:49:25,407 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1142.879997600252;1195.3126952002594;1198.820176973454;1537.8462153784617;1562.6015366081647;5850.765969361226;5926.170336152936;6024.126501657262;6251.187345645059;6364.649944253064;6897.206821215562;7039.577625342483;7096.112985876765;7166.068411106562;7176.964115179417;1935.4677463697456;1980.3761815028292;1980.6137803128395;2008.086320724067;2011.7988201179912;2001.419588319393;2032.5629989552244;2047.8464115191346;2056.7429071366078;2062.102985201435;1938.3603410874448;1972.566035472201;1983.4644645945586;2007.7791442941266;2013.2852837242715;1979.346815550872;1981.5739615982634;2004.929827456032;2012.788657191003;2013.2550956146247;1931.893745843978;1968.507873031742;1975.9209631614717;2021.20162535799;2033.3391647714552;7187.389071928892;7189.352958233784;7252.093488313961;7254.492185546961;7295.161056478467;4272.786360681954;4336.132773445323;4368.257396242647;4391.49497807753;4410.338449232609;2259.412552736284;2307.3654744945106;2498.1880888711244;2540.8221424500293;2572.704139023999;772.2933515833063;814.4705941138249;820.9671613135467;1335.71282174332;1385.681293302546;9506.334556581041;9613.567389467491;9684.51577421126;9756.365836220622;9756.365836220693;3588.1567831559564;3599.6400359963795;3696.7966761828357;3697.8335974881193;3732.552093748713;7270.236625154388;7275.345218930216;7304.452166087564;7353.1911489736085;7361.411087113018;4116.608922152451;4158.355454904495;4217.240896638635;4221.598948099926;4224.471941007374;3862.1503269280715;3873.3996230584303;3921.568627450978;3921.6666583340734;3930.7445016074435;2986.4176485585103;2995.8202507849164;3006.2334104803135;3030.9545356819667;3035.9241018974703;915.496476937695;935.9110884465965;936.1855185988234;937.9953100234455;941.6374695742188;921.9723408297762;938.5307346326837;1128.480898786551;1128.4865386249237;1132.2017977325966;6614.536982411185;6755.324467553205;6782.050512928194;6862.4853136014;6867.313268673092;387.5775404808772;387.77702820877545;389.6804620211456;390.2273498472983;390.9179072394772;5214.84355469329;5284.101702710548;5284.154535274338;5368.946310536923;5389.407165211824;7778.611069446505;7959.562224077731;8489.702860399857;8543.572821358906;8615.741527754177;8495.660173592987;8504.744857654281;8520;8584.785380365542;8592;6535.640539770358;6610.206775186912;6695.531312808154;6729.596224226562;6796.15048118995;6703.664816759045;6730.293319201609;6737.157855268091;6742.9662851685425;6746.898796517958;7352.191258961617;7683.346915512244;7761.573113478587;7810;7812;7603.695852165852;7806.726764563213;7811.296983271533;7813.453058285865;7849.411294152847;5964;6013.338532761305;6029.352643673604;6092.543059270483;6109.75560977556;6482.805515834532;6491.935080649133;6548.901766473411;6553.4101930826455;6565.343465653396;6026.789062382795;6126.908096378469;6171.47542458896;6220.129181914445;6234.314225435108;5979.073243647242;6046.969765151146;6068.150458935665;6106.603070800384;6126.663033533198;6112.541559383153;6187.195664563758;6201.255849298113;6211.9068213977735;6230.59501132425;5598.552115830806;5639.915401269066;5642.23829782974;5647.915281270866;5652.886942261214;5336.466353364788;5376.758045888023;5407.324084489439;5433.130699088285;5454.236406903116 05:49:25 INFO - 2015-11-06 05:49:25,408 DEBUG : BROWSER_OUTPUT: |4;prototype.html;270.2406238469899;272.4075136577943;278.57934518876493;279.1945237988403;280.6253651375414;5207.479252074791;5329.813456529013;5365.03429382711;5401.081816091269;5479.753411096501;5154.793808247666;5269.262303277545;5275.788968441268;5283.6037297202765;5319.255304257407;4082.4080508326274;4098.4671992640915;4138.648214901722;4139.337705967046;4139.523954745206;4088.2232375848644;4108.157827645326;4127.360259159835;4140.151268989865;4150;3948.565657777642;4017.537983131948;4054.8986275343204;4109.671226301889;4129.359949207877;4043.8180281887385;4056.371262454339;4077.1845630873945;4107.568705285947;4116.547179810218;3381.661833816623;3453.0504111369323;3458;3466;3484.407650699387;5161.4322424533275;5171.431142574352;5176.637635365526;5203.895922081575;5228.346456692913;4499.1451624191295;4504.752238626874;4507.098580283956;4563.954360456386;4581.1753884300815;5414.10667239905;5504.422035686275;5517;5561.443855614447;5682.801101961453;3668.853245870162;3673.210259794157;3683.2633473305445;3713.3687273163355;3730.2166545025575;5780.277465316835;5782.306123265235;5807.186993820868;5849.649021058707;5872.500837428824;3627.619099994515;3653.9586217927763;3711.9628803712158;3730.309892669865;3741.962580374216;3589.246258285737;3715.4241092630145;3731.1418373774186;3838.2899163654815;3850.7882066486054;4380.036391993756;4427.490838553607;4435.401220835146;4438.400815889813;4466.330050492387;5537.778488860481;5552.056150454432;5556.833295001156;5559.610827242135;5599.60802743804;1336.7994800779961;1360.3674291454522;1371.2937837013947;1374.896882733799;1377.7313423882447;847.7965288330756;858.7552547523926;878.3236907581127;879.7009016934273;889.2663552569156;5238.973805131026;5284.07528682479;5291.074062039128;5308.601854860824;5318.414974352818;5754.108113242454;5836.212111364996;5849.210356601804;5853.443922827325;5859.912101318484;5226.973865130726;5302.019126461617;5302.3637163540625;5304.734763261821;5305.389880163753;3108.5492603572357;3193.3134376109247;3223.8065716057113;3236.4336241157703;3244.3024749678934;5973.044312909914;6000.159977603139;6000.849978750479;6002.0996850472775;6004.729787159588;5922.407759224043;5948.583599148018;5957.851053723692;5967.403259673998;5999.220101386792;5899.616524925866;5980.521558275327;5982.0727787193055;5991.370906054802;6063.575549711478;5808.5062769665055;5819.621724587888;5820.330661973927;5860.531157507475;5906.497947674324;5715.914261286167;5729.8567535811935;5737.139429085671;5778.595498315078;5792.913106303325;5997.820065398045;6003.519718422428;6010.849728756816;6069.119977603311;6089.54328425361;3686.04162917638;3693.464447655129;3766.661000509858;3768.5477742671055;3778.9055273617278;5561.443855614406;5704.8003319885265;5728.79949201776;5730.541556675373;5735.369109398046;5517.200005999188;5577.051901176891;5581.330240371181;5611.74747136388;5683.403242659461;5566.666000039849;5571.9442805571425;5606.2431571738925;5644.181593668977;5662.2639056922335;5263.026340127089;5439.184122381675;5440.7551660174595;5498.697571633598;5528.115501519737;5576.776928922797;5642.774289028393;5663.631863928831;5688.260526131577;5703.714814259188;5509.256250406304;5532.28080349552;5549.861253468695;5566.332040155207;5607.495325420732 05:49:25 INFO - 2015-11-06 05:49:25,411 DEBUG : BROWSER_OUTPUT: |5;yui.html;558.5810642018486;580.669018659364;609.1806520230289;634.2104080419876;638.3190599482175;11850.881491185086;12154.270743755358;12195.634130976085;12205.023598112162;12242.326672033047;10939.726506837333;11357.091432685385;11412.885871141287;11437.714057148554;12037.638870833867;743.8995735575683;751.7819832248641;757.5000499670218;765.6401491299108;766.8082979255187;750.0511852506584;751.2675141736818;759.9734009309675;760.5284723471427;761.958092304923;784.8194915169514;788.7949133225345;799.9120096789349;800.8798680197988;801.4309840013598;782.8003859015943;786.0057027859762;789.5460110436522;792.9643166057541;792.9722459713911;580.5094694982732;584.1092334190394;585.970701464925;591.6686655472948;592.4223881715336;11656.59201927937;11702.882971170264;11811.114166437552;11826;11866.466009029615;10063.496825158785;10112.241581881315;10240.129588984944;10263.589456421734;10693.78612427747;7666.386689064917;7882.80292992674;7905.604719764046;7959.204079592052;7986.6805327786815;2578.200757765099;2620.6200100985443;2694.420699549606;2709.6612923384578;2736.904208352698;34576.48135277973;35163.4725479118;41364.759057228635;41995.58004419947;42926.35610465846;5837.3870743571315;5898.174255604219;5910.704464776744;5960.135780311917;6128.908066379008;10340.896591034143;10386.740331491774;10444;10488.31825931312;10549.103326217357;5277.8416647500635;5320.76056577455;5331.946680533222;5373.731313434391;5478;3117.5791268178505;3159.5418664293547;3252.4308246057317;3288.0629020729457;3381.594208694972;2343.953120937572;2377.9524409511714;2378.345954862427;2380.6071998120465;2400.8079353652015;341.95041718950614;393.8877419935305;402.32610377617374;409.44724621760383;415.4495293735812;363.6835952721149;439.86295426322675;496.12096654642204;528.8810017745976;529.377980872481;6378.840528986812;6703.832404189934;6745.932540674628;6788.7284508619105;6834.384905358542;500.65955150498013;509.4472497340427;513.7482633509553;529.282821776495;531.6331731105524;3403.846826892796;3486.372452958441;3535.646435356495;3554.2809750540855;3652.415613501827;52730;54287;54422.72788636031;54593.727031365386;54600.72699636476;47030;47201.05597888023;47333;47793.52206477891;47939;39463.21073578512;39893.202135957115;40301.1939761209;40814.183716325504;42991;6717.764878229434;6972.926595813285;7174.784756457315;7292.416606671348;7426.108866935786;31273.8436307817;31653.36693266168;32521.349573007934;32578.022659320257;32636.83681581577;39045.21909561849;39079.60920390873;39466.21067578575;42873;42920;6481.189851268591;6518;6596.70314835824;6633.005049242653;6674.132362792806;9396.295277854326;9543.713688589354;9611.183049440597;9701.514924253901;10312.587496500057;8629.83940563217;8702.390832641655;8844.513551754715;8996.190342869173;9084.091590840862;8570.4000719949;8760.167784060504;8886.822263554823;8906.287497000354;9014.233790127913;8262;8883.555822208993;8926.419782714103;9259.35184537076;9274.814503709753;7471.140818805907;7809.180036096128;7981.241782030698;8083.797905052421;8119.350451963711;7161.85676286461;7708.768736937901;7716.961415192888;7939.682412703427;7955.164707705608 05:49:25 INFO - 2015-11-06 05:49:25,412 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:49:25 INFO - 2015-11-06 05:49:25,412 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:49:25 INFO - 2015-11-06 05:49:25,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 05:49:25 INFO - 2015-11-06 05:49:25,412 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:49:25 INFO - 2015-11-06 05:49:25,412 DEBUG : BROWSER_OUTPUT: __startTimestamp1446817765396__endTimestamp 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4628.95 Median:4786.11 stddev:591.56 (12.4%) stddev-sans-first:573.19 05:49:25 INFO - 2015-11-06 05:49:25,413 DEBUG : BROWSER_OUTPUT: Values: 2675.7 2729.2 2732.0 2758.6 2820.5 4650.2 4676.1 4784.2 4795.8 4838.6 4531.6 4604.7 4632.9 4666.5 4712.2 4409.2 4431.0 4470.0 4494.5 4520.2 494.6 4149.5 4359.8 4420.5 4496.5 4237.2 4319.0 4324.0 4352.3 4434.3 4320.0 4387.9 4398.4 4445.2 4475.8 4191.0 4214.2 4350.3 4405.9 4426.9 4436.3 4531.6 4568.9 4620.4 4650.9 4902.1 4932.5 4982.0 4983.4 4983.8 4836.6 4958.0 4982.3 5065.6 5083.3 4705.6 4710.6 4728.7 4729.8 4733.9 5098.8 5136.6 5138.8 5192.8 5205.0 4712.5 4781.1 4786.1 4845.3 4846.1 4840.2 4971.2 5032.6 5035.1 5038.9 4893.6 4909.9 4915.5 4968.2 4980.6 4886.3 4887.9 4952.3 4982.9 4989.3 3854.3 3856.4 3870.8 3935.7 3936.4 3467.5 3494.2 3518.6 3541.3 3545.8 4351.3 4636.1 4676.6 4692.7 4707.2 4994.5 5072.1 5079.3 5091.4 5091.8 4639.3 4665.0 4702.6 4743.9 4767.4 4282.2 4332.5 4420.3 4437.4 4547.5 5127.6 5149.4 5165.1 5186.2 5200.3 5013.8 5053.2 5094.0 5117.4 5131.6 4937.4 5008.1 5092.3 5223.1 5244.4 4814.7 4825.8 4907.0 4923.5 4931.5 4780.5 4876.9 4985.4 5026.1 5073.5 4665.0 4879.2 4893.2 4943.6 4960.5 4892.6 4899.8 4925.0 4930.1 4932.6 4580.8 4645.2 4663.4 4668.8 4817.2 4721.5 4883.8 4885.2 4899.4 4938.7 4766.4 4788.5 4814.6 4825.0 4825.3 05:49:25 INFO - 2015-11-06 05:49:25,414 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,414 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39904.88 Median:34783.83 stddev:62500.12 (179.7%) stddev-sans-first:62605.36 05:49:25 INFO - 2015-11-06 05:49:25,415 DEBUG : BROWSER_OUTPUT: Values: 485.9 489.5 506.1 506.9 521.6 33994.8 35143.6 35246.8 35287.5 35351.5 36351.0 37876.8 37905.8 37919.6 37922.8 7727.9 7871.1 7985.5 8001.6 8018.3 7797.5 7854.1 7959.0 7963.2 7966.6 7713.5 7926.7 7941.6 7943.5 7949.6 7749.8 7862.3 7937.9 7952.2 7956.4 7689.6 7701.6 7704.0 7811.3 7817.4 34213.3 34302.3 34753.8 34783.7 34784.0 2171.4 2344.5 2476.3 2665.1 2712.7 23481.1 23878.2 23976.9 24049.6 24141.2 1996.9 2022.4 2031.5 2032.8 2045.6 216565.0 217641.0 218632.0 220403.0 220620.0 50762.7 51016.5 51365.5 51384.5 51453.7 61728.0 62158.4 62915.0 62998.7 63072.4 14266.4 14467.5 14474.7 14556.1 14641.2 11059.9 11097.0 11123.9 11153.9 11265.3 16775.2 17855.5 17900.4 17932.6 18134.9 7257.9 7534.7 7557.4 7566.0 7568.5 778.3 796.6 818.7 828.2 918.7 24744.5 25176.2 25194.0 25200.1 25247.9 901.5 961.1 980.2 985.9 1016.7 12919.5 13042.4 13085.5 13144.9 13157.7 252940.0 256860.0 257126.0 261171.0 261907.0 47243.3 47859.0 47866.3 48385.0 48532.0 1187.4 1194.9 1198.7 1204.1 1208.7 24314.8 24353.3 24425.9 24715.6 24843.6 41785.4 41813.6 42304.0 42361.4 42879.4 239550.0 240232.0 240537.0 240812.0 242377.0 27873.0 36412.3 37857.4 37950.6 38024.2 34994.7 35016.3 35668.6 40327.0 43075.1 32929.5 34902.2 35094.1 35186.6 35740.3 31147.2 31518.4 31769.0 31886.2 32112.6 32100.2 32490.8 34287.8 35588.6 35634.8 26144.7 28218.9 28279.9 28392.6 28940.1 21085.0 21242.5 21249.8 21281.1 21288.3 05:49:25 INFO - 2015-11-06 05:49:25,416 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,417 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23339.79 Median:246032.82 stddev:79347.31 (32.3%) stddev-sans-first:79551.01 05:49:25 INFO - 2015-11-06 05:49:25,418 DEBUG : BROWSER_OUTPUT: Values: 284.3 286.7 291.0 291.4 295.1 13912.4 14549.5 15014.5 15190.2 16097.3 15182.2 15207.8 15551.8 15608.2 15727.4 4327.6 4539.9 4544.9 4547.3 4564.8 4529.9 4584.6 4601.6 4605.7 4655.0 3383.6 4558.2 4586.2 4868.6 4956.8 4602.0 4829.7 4830.6 4889.3 4901.5 3211.1 3292.4 4288.2 4304.3 4306.0 10740.9 10854.2 11032.1 11053.4 11230.7 1596.5 1605.4 1628.0 1678.3 1695.4 7796.3 7957.2 7998.8 8071.2 8214.1 1297.7 1326.6 1334.3 1339.2 1359.8 47995.8 49583.5 49813.8 50230.0 50561.2 5305.8 5314.6 5399.2 5428.1 5450.5 6075.5 6086.0 6158.6 6167.7 6170.6 4473.0 4555.8 4607.5 4615.6 4616.4 4915.3 4928.7 4943.9 4996.0 5027.3 2410.5 2412.9 2418.0 2439.0 2440.6 856.9 861.2 865.4 872.2 920.4 322.8 323.6 358.9 373.0 383.8 9533.4 9817.2 9876.0 9932.7 9972.1 384.5 389.8 392.8 392.8 414.9 4998.5 5224.4 5270.9 5295.3 5366.7 472505.0 477253.0 487197.0 490809.0 495249.0 56102.0 57197.1 61268.0 61569.0 64898.7 408.8 415.5 419.5 420.7 420.7 8701.8 9037.9 9223.9 9261.8 9418.9 24450.8 28668.0 29413.7 29511.3 31442.2 40489.6 40677.6 41112.0 41219.6 41628.8 5102.8 5133.9 5156.9 5214.6 5216.2 9609.0 9743.6 9790.5 9864.3 9888.0 8309.2 8370.6 8459.3 8555.6 8654.5 1897.6 5041.4 6877.7 7913.2 8331.7 8191.6 8610.7 8615.7 8632.3 8671.1 4942.8 5075.0 5083.0 5088.9 5154.7 8205.4 8401.4 8419.2 8496.5 8502.3 05:49:25 INFO - 2015-11-06 05:49:25,418 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,418 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4817.47 Median:6025.46 stddev:2557.82 (42.5%) stddev-sans-first:2550.08 05:49:25 INFO - 2015-11-06 05:49:25,419 DEBUG : BROWSER_OUTPUT: Values: 1142.9 1195.3 1198.8 1537.8 1562.6 5850.8 5926.2 6024.1 6251.2 6364.6 6897.2 7039.6 7096.1 7166.1 7177.0 1935.5 1980.4 1980.6 2008.1 2011.8 2001.4 2032.6 2047.8 2056.7 2062.1 1938.4 1972.6 1983.5 2007.8 2013.3 1979.3 1981.6 2004.9 2012.8 2013.3 1931.9 1968.5 1975.9 2021.2 2033.3 7187.4 7189.4 7252.1 7254.5 7295.2 4272.8 4336.1 4368.3 4391.5 4410.3 2259.4 2307.4 2498.2 2540.8 2572.7 772.3 814.5 821.0 1335.7 1385.7 9506.3 9613.6 9684.5 9756.4 9756.4 3588.2 3599.6 3696.8 3697.8 3732.6 7270.2 7275.3 7304.5 7353.2 7361.4 4116.6 4158.4 4217.2 4221.6 4224.5 3862.2 3873.4 3921.6 3921.7 3930.7 2986.4 2995.8 3006.2 3031.0 3035.9 915.5 935.9 936.2 938.0 941.6 922.0 938.5 1128.5 1128.5 1132.2 6614.5 6755.3 6782.1 6862.5 6867.3 387.6 387.8 389.7 390.2 390.9 5214.8 5284.1 5284.2 5368.9 5389.4 7778.6 7959.6 8489.7 8543.6 8615.7 8495.7 8504.7 8520.0 8584.8 8592.0 6535.6 6610.2 6695.5 6729.6 6796.2 6703.7 6730.3 6737.2 6743.0 6746.9 7352.2 7683.3 7761.6 7810.0 7812.0 7603.7 7806.7 7811.3 7813.5 7849.4 5964.0 6013.3 6029.4 6092.5 6109.8 6482.8 6491.9 6548.9 6553.4 6565.3 6026.8 6126.9 6171.5 6220.1 6234.3 5979.1 6047.0 6068.2 6106.6 6126.7 6112.5 6187.2 6201.3 6211.9 6230.6 5598.6 5639.9 5642.2 5647.9 5652.9 5336.5 5376.8 5407.3 5433.1 5454.2 05:49:25 INFO - 2015-11-06 05:49:25,419 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,419 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4655.58 Median:5318.84 stddev:1439.24 (27.1%) stddev-sans-first:1405.14 05:49:25 INFO - 2015-11-06 05:49:25,420 DEBUG : BROWSER_OUTPUT: Values: 270.2 272.4 278.6 279.2 280.6 5207.5 5329.8 5365.0 5401.1 5479.8 5154.8 5269.3 5275.8 5283.6 5319.3 4082.4 4098.5 4138.6 4139.3 4139.5 4088.2 4108.2 4127.4 4140.2 4150.0 3948.6 4017.5 4054.9 4109.7 4129.4 4043.8 4056.4 4077.2 4107.6 4116.5 3381.7 3453.1 3458.0 3466.0 3484.4 5161.4 5171.4 5176.6 5203.9 5228.3 4499.1 4504.8 4507.1 4564.0 4581.2 5414.1 5504.4 5517.0 5561.4 5682.8 3668.9 3673.2 3683.3 3713.4 3730.2 5780.3 5782.3 5807.2 5849.6 5872.5 3627.6 3654.0 3712.0 3730.3 3742.0 3589.2 3715.4 3731.1 3838.3 3850.8 4380.0 4427.5 4435.4 4438.4 4466.3 5537.8 5552.1 5556.8 5559.6 5599.6 1336.8 1360.4 1371.3 1374.9 1377.7 847.8 858.8 878.3 879.7 889.3 5239.0 5284.1 5291.1 5308.6 5318.4 5754.1 5836.2 5849.2 5853.4 5859.9 5227.0 5302.0 5302.4 5304.7 5305.4 3108.5 3193.3 3223.8 3236.4 3244.3 5973.0 6000.2 6000.8 6002.1 6004.7 5922.4 5948.6 5957.9 5967.4 5999.2 5899.6 5980.5 5982.1 5991.4 6063.6 5808.5 5819.6 5820.3 5860.5 5906.5 5715.9 5729.9 5737.1 5778.6 5792.9 5997.8 6003.5 6010.8 6069.1 6089.5 3686.0 3693.5 3766.7 3768.5 3778.9 5561.4 5704.8 5728.8 5730.5 5735.4 5517.2 5577.1 5581.3 5611.7 5683.4 5566.7 5571.9 5606.2 5644.2 5662.3 5263.0 5439.2 5440.8 5498.7 5528.1 5576.8 5642.8 5663.6 5688.3 5703.7 5509.3 5532.3 5549.9 5566.3 5607.5 05:49:25 INFO - 2015-11-06 05:49:25,420 DEBUG : BROWSER_OUTPUT: 05:49:25 INFO - 2015-11-06 05:49:25,421 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11647.34 Median:29830.37 stddev:14555.73 (48.8%) stddev-sans-first:14572.74 05:49:25 INFO - 2015-11-06 05:49:25,422 DEBUG : BROWSER_OUTPUT: Values: 558.6 580.7 609.2 634.2 638.3 11850.9 12154.3 12195.6 12205.0 12242.3 10939.7 11357.1 11412.9 11437.7 12037.6 743.9 751.8 757.5 765.6 766.8 750.1 751.3 760.0 760.5 762.0 784.8 788.8 799.9 800.9 801.4 782.8 786.0 789.5 793.0 793.0 580.5 584.1 586.0 591.7 592.4 11656.6 11702.9 11811.1 11826.0 11866.5 10063.5 10112.2 10240.1 10263.6 10693.8 7666.4 7882.8 7905.6 7959.2 7986.7 2578.2 2620.6 2694.4 2709.7 2736.9 34576.5 35163.5 41364.8 41995.6 42926.4 5837.4 5898.2 5910.7 5960.1 6128.9 10340.9 10386.7 10444.0 10488.3 10549.1 5277.8 5320.8 5331.9 5373.7 5478.0 3117.6 3159.5 3252.4 3288.1 3381.6 2344.0 2378.0 2378.3 2380.6 2400.8 342.0 393.9 402.3 409.4 415.4 363.7 439.9 496.1 528.9 529.4 6378.8 6703.8 6745.9 6788.7 6834.4 500.7 509.4 513.7 529.3 531.6 3403.8 3486.4 3535.6 3554.3 3652.4 52730.0 54287.0 54422.7 54593.7 54600.7 47030.0 47201.1 47333.0 47793.5 47939.0 39463.2 39893.2 40301.2 40814.2 42991.0 6717.8 6972.9 7174.8 7292.4 7426.1 31273.8 31653.4 32521.3 32578.0 32636.8 39045.2 39079.6 39466.2 42873.0 42920.0 6481.2 6518.0 6596.7 6633.0 6674.1 9396.3 9543.7 9611.2 9701.5 10312.6 8629.8 8702.4 8844.5 8996.2 9084.1 8570.4 8760.2 8886.8 8906.3 9014.2 8262.0 8883.6 8926.4 9259.4 9274.8 7471.1 7809.2 7981.2 8083.8 8119.4 7161.9 7708.8 7717.0 7939.7 7955.2 05:49:25 INFO - 2015-11-06 05:49:25,422 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:49:25 INFO - 2015-11-06 05:49:25,422 DEBUG : BROWSER_OUTPUT: 05:49:26 INFO - 2015-11-06 05:49:26,098 INFO : Browser exited with error code: 0 05:49:26 INFO - 2015-11-06 05:49:26,131 INFO : Completed test dromaeo_css (00:18:32) 05:49:26 INFO - 2015-11-06 05:49:26,131 INFO : Starting test kraken 05:49:26 INFO - 2015-11-06 05:49:26,131 DEBUG : operating with platform_type : mac_ 05:49:26 INFO - 2015-11-06 05:49:26,131 INFO : Initialising browser for kraken test... 05:49:26 INFO - 2015-11-06 05:49:26,148 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpNgIae6/profile http://localhost:51242/getInfo.html 05:49:29 INFO - 2015-11-06 05:49:29,323 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:49:29 INFO - 2015-11-06 05:49:29,323 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:49:29 INFO - 2015-11-06 05:49:29,324 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:49:29 INFO - 2015-11-06 05:49:29,324 DEBUG : BROWSER_OUTPUT: __metrics 05:49:30 INFO - 2015-11-06 05:49:30,040 INFO : Browser initialized. 05:49:30 INFO - 2015-11-06 05:49:30,040 INFO : Running cycle 1/1 for kraken test... 05:49:30 INFO - 2015-11-06 05:49:30,041 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpNgIae6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:49:42 INFO - 2015-11-06 05:49:42,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 233697280 05:49:42 INFO - 2015-11-06 05:49:42,148 DEBUG : BROWSER_OUTPUT: 05:49:44 INFO - 2015-11-06 05:49:44,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:45 INFO - 2015-11-06 05:49:45,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 252125184 05:49:45 INFO - 2015-11-06 05:49:45,595 DEBUG : BROWSER_OUTPUT: 05:49:48 INFO - 2015-11-06 05:49:48,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-dft) 05:49:49 INFO - 2015-11-06 05:49:49,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 260046848 05:49:49 INFO - 2015-11-06 05:49:49,215 DEBUG : BROWSER_OUTPUT: 05:49:52 INFO - 2015-11-06 05:49:52,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-fft) 05:49:53 INFO - 2015-11-06 05:49:53,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 259518464 05:49:53 INFO - 2015-11-06 05:49:53,096 DEBUG : BROWSER_OUTPUT: 05:49:55 INFO - 2015-11-06 05:49:55,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-oscillator) 05:49:55 INFO - 2015-11-06 05:49:55,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 259870720 05:49:55 INFO - 2015-11-06 05:49:55,842 DEBUG : BROWSER_OUTPUT: 05:49:58 INFO - 2015-11-06 05:49:58,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:58 INFO - 2015-11-06 05:49:58,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 260595712 05:49:58 INFO - 2015-11-06 05:49:58,804 DEBUG : BROWSER_OUTPUT: 05:50:02 INFO - 2015-11-06 05:50:02,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:02 INFO - 2015-11-06 05:50:02,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 261910528 05:50:02 INFO - 2015-11-06 05:50:02,859 DEBUG : BROWSER_OUTPUT: 05:50:06 INFO - 2015-11-06 05:50:06,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:07 INFO - 2015-11-06 05:50:07,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 258650112 05:50:07 INFO - 2015-11-06 05:50:07,018 DEBUG : BROWSER_OUTPUT: 05:50:10 INFO - 2015-11-06 05:50:10,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51242/tests/kraken/driver.html?testName=json-parse-financial) 05:50:10 INFO - 2015-11-06 05:50:10,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 261226496 05:50:10 INFO - 2015-11-06 05:50:10,894 DEBUG : BROWSER_OUTPUT: 05:50:12 INFO - 2015-11-06 05:50:12,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:13 INFO - 2015-11-06 05:50:13,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 260452352 05:50:13 INFO - 2015-11-06 05:50:13,206 DEBUG : BROWSER_OUTPUT: 05:50:15 INFO - 2015-11-06 05:50:15,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:15 INFO - 2015-11-06 05:50:15,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 260608000 05:50:15 INFO - 2015-11-06 05:50:15,860 DEBUG : BROWSER_OUTPUT: 05:50:18 INFO - 2015-11-06 05:50:18,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:18 INFO - 2015-11-06 05:50:18,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 260800512 05:50:18 INFO - 2015-11-06 05:50:18,790 DEBUG : BROWSER_OUTPUT: 05:50:21 INFO - 2015-11-06 05:50:21,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:22 INFO - 2015-11-06 05:50:22,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 260206592 05:50:22 INFO - 2015-11-06 05:50:22,309 DEBUG : BROWSER_OUTPUT: 05:50:25 INFO - 2015-11-06 05:50:25,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:25 INFO - 2015-11-06 05:50:25,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 260653056 05:50:25 INFO - 2015-11-06 05:50:25,879 DEBUG : BROWSER_OUTPUT: 05:50:27 INFO - 2015-11-06 05:50:27,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51242/tests/kraken/driver.html?testName=ai-astar) 05:50:28 INFO - 2015-11-06 05:50:28,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 261156864 05:50:28 INFO - 2015-11-06 05:50:28,046 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,046 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:28 INFO - 2015-11-06 05:50:28,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;125;132;131;127;139;133;135;133;128 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;163;183;195;155;179;178;157;189;158 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;201;209;203;201;196;193;200;206;197 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |3;audio-fft;82;87;100;145;80;86;82;80;116;80 05:50:28 INFO - 2015-11-06 05:50:28,047 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;109;151;106;110;109;143;102;110;152 05:50:28 INFO - 2015-11-06 05:50:28,048 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;141;143;151;150;137;143;143;136;143 05:50:28 INFO - 2015-11-06 05:50:28,048 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;157;148;157;156;150;158;156;149;157 05:50:28 INFO - 2015-11-06 05:50:28,048 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;121;128;127;128;126;130;127;122;128;129 05:50:28 INFO - 2015-11-06 05:50:28,048 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;72;75;78;77;76;76;83;75;75 05:50:28 INFO - 2015-11-06 05:50:28,048 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;81;84;84;83;85;81;80;81;80 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;106;107;110;108;108;109;102;103;107 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;159;165;162;152;156;151;149;156;153;164 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;191;193;188;183;176;191;193;186;185 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;83;87;91;89;84;92;86;88;88 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:28 INFO - 2015-11-06 05:50:28,049 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,739 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: __startTimestamp1446817828040__endTimestamp 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:50:28 INFO - 2015-11-06 05:50:28,050 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.00 Median:132.50 stddev:4.29 (3.2%) stddev-sans-first:4.30 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: Values: 127.0 125.0 132.0 131.0 127.0 139.0 133.0 135.0 133.0 128.0 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.50 Median:178.50 stddev:14.25 (8.0%) stddev-sans-first:15.02 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: Values: 178.0 163.0 183.0 195.0 155.0 179.0 178.0 157.0 189.0 158.0 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,051 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:199.70 Median:201.00 stddev:5.60 (2.8%) stddev-sans-first:4.97 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: Values: 191.0 201.0 209.0 203.0 201.0 196.0 193.0 200.0 206.0 197.0 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.80 Median:81.00 stddev:21.37 (26.4%) stddev-sans-first:22.23 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: Values: 82.0 87.0 100.0 145.0 80.0 86.0 82.0 80.0 116.0 80.0 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,052 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.70 Median:110.00 stddev:20.28 (18.4%) stddev-sans-first:20.80 05:50:28 INFO - 2015-11-06 05:50:28,053 DEBUG : BROWSER_OUTPUT: Values: 105.0 109.0 151.0 106.0 110.0 109.0 143.0 102.0 110.0 152.0 05:50:28 INFO - 2015-11-06 05:50:28,053 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,053 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.70 Median:143.00 stddev:5.23 (3.7%) stddev-sans-first:5.02 05:50:28 INFO - 2015-11-06 05:50:28,053 DEBUG : BROWSER_OUTPUT: Values: 150.0 141.0 143.0 151.0 150.0 137.0 143.0 143.0 136.0 143.0 05:50:28 INFO - 2015-11-06 05:50:28,053 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,054 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.50 Median:157.00 stddev:3.87 (2.5%) stddev-sans-first:3.99 05:50:28 INFO - 2015-11-06 05:50:28,054 DEBUG : BROWSER_OUTPUT: Values: 157.0 157.0 148.0 157.0 156.0 150.0 158.0 156.0 149.0 157.0 05:50:28 INFO - 2015-11-06 05:50:28,054 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,054 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:126.60 Median:128.00 stddev:2.91 (2.3%) stddev-sans-first:2.28 05:50:28 INFO - 2015-11-06 05:50:28,054 DEBUG : BROWSER_OUTPUT: Values: 121.0 128.0 127.0 128.0 126.0 130.0 127.0 122.0 128.0 129.0 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.70 Median:76.00 stddev:3.47 (4.6%) stddev-sans-first:3.00 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 75.0 78.0 77.0 76.0 76.0 83.0 75.0 75.0 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:82.00 stddev:2.21 (2.7%) stddev-sans-first:1.90 05:50:28 INFO - 2015-11-06 05:50:28,055 DEBUG : BROWSER_OUTPUT: Values: 78.0 81.0 84.0 84.0 83.0 85.0 81.0 80.0 81.0 80.0 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:106.30 Median:107.50 stddev:2.75 (2.6%) stddev-sans-first:2.65 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: Values: 103.0 106.0 107.0 110.0 108.0 108.0 109.0 102.0 103.0 107.0 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:157.50 stddev:5.62 (3.6%) stddev-sans-first:5.90 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: Values: 159.0 165.0 162.0 152.0 156.0 151.0 149.0 156.0 153.0 164.0 05:50:28 INFO - 2015-11-06 05:50:28,056 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,057 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:189.50 stddev:7.35 (3.9%) stddev-sans-first:5.55 05:50:28 INFO - 2015-11-06 05:50:28,057 DEBUG : BROWSER_OUTPUT: Values: 171.0 191.0 193.0 188.0 183.0 176.0 191.0 193.0 186.0 185.0 05:50:28 INFO - 2015-11-06 05:50:28,057 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,057 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.80 Median:88.00 stddev:3.68 (4.2%) stddev-sans-first:2.96 05:50:28 INFO - 2015-11-06 05:50:28,058 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 87.0 91.0 89.0 84.0 92.0 86.0 88.0 88.0 05:50:28 INFO - 2015-11-06 05:50:28,059 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:28 INFO - 2015-11-06 05:50:28,059 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-06 05:50:28,833 INFO : Browser exited with error code: 0 05:50:28 INFO - 2015-11-06 05:50:28,887 INFO : Completed test kraken (00:01:02) 05:50:28 INFO - 2015-11-06 05:50:28,887 INFO : Starting test v8_7 05:50:28 INFO - 2015-11-06 05:50:28,887 DEBUG : operating with platform_type : mac_ 05:50:28 INFO - 2015-11-06 05:50:28,887 INFO : Initialising browser for v8_7 test... 05:50:28 INFO - 2015-11-06 05:50:28,903 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpPA3ano/profile http://localhost:51242/getInfo.html 05:50:31 INFO - 2015-11-06 05:50:31,960 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:31 INFO - 2015-11-06 05:50:31,961 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:31 INFO - 2015-11-06 05:50:31,961 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:50:31 INFO - 2015-11-06 05:50:31,961 DEBUG : BROWSER_OUTPUT: __metrics 05:50:32 INFO - 2015-11-06 05:50:32,657 INFO : Browser initialized. 05:50:32 INFO - 2015-11-06 05:50:32,658 INFO : Running cycle 1/1 for v8_7 test... 05:50:32 INFO - 2015-11-06 05:50:32,658 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpPA3ano/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:50:44 INFO - 2015-11-06 05:50:44,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 234287104 05:50:44 INFO - 2015-11-06 05:50:44,735 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/v8_7/run.html (next: http://localhost:51242/tests/v8_7/run.html) 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 248356864 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:51:07 INFO - 2015-11-06 05:51:07,596 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |0;Richards;193.53590090961873 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;242.306760358614 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |2;Encrypt;372.0238095238095 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6804.054054054054 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1333.3333333333333 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |5;Earley;1047.071129707113 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |6;Boyer;14779.411764705883 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |7;RegExp;33900 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |8;Splay;775.7951900698216 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6802.721088435374 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:51:07 INFO - 2015-11-06 05:51:07,597 DEBUG : BROWSER_OUTPUT: __startTimestamp1446817867593__endTimestamp 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:193.54 Median:193.54 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: Values: 193.5 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:242.31 Median:242.31 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: Values: 242.3 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,598 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:372.02 Median:372.02 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: Values: 372.0 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6804.05 Median:6804.05 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: Values: 6804.1 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1333.33 Median:1333.33 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: Values: 1333.3 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1047.07 Median:1047.07 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: Values: 1047.1 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14779.41 Median:14779.41 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,599 DEBUG : BROWSER_OUTPUT: Values: 14779.4 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33900.00 Median:33900.00 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: Values: 33900.0 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:775.80 Median:775.80 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: Values: 775.8 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6802.72 Median:6802.72 stddev:0.00 (0.0%) 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: Values: 6802.7 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:51:07 INFO - 2015-11-06 05:51:07,600 DEBUG : BROWSER_OUTPUT: 05:51:08 INFO - 2015-11-06 05:51:08,296 INFO : Browser exited with error code: 0 05:51:08 INFO - 2015-11-06 05:51:08,320 INFO : Completed test v8_7 (00:00:39) 05:51:08 INFO - 2015-11-06 05:51:08,582 INFO : Completed test suite (00:20:15) 05:51:08 INFO - 2015-11-06 05:51:08,583 DEBUG : Working with test: dromaeo_css 05:51:08 INFO - 2015-11-06 05:51:08,583 DEBUG : Generating results file: dromaeo_css 05:51:08 INFO - 2015-11-06 05:51:08,584 DEBUG : Working with test: kraken 05:51:08 INFO - 2015-11-06 05:51:08,584 DEBUG : Generating results file: kraken 05:51:08 INFO - 2015-11-06 05:51:08,584 INFO : javascript benchmark 05:51:08 INFO - 2015-11-06 05:51:08,584 DEBUG : Working with test: v8_7 05:51:08 INFO - 2015-11-06 05:51:08,584 DEBUG : Generating results file: v8_7 05:51:08 INFO - 2015-11-06 05:51:08,584 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:08 INFO - 2015-11-06 05:51:08,745 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 05:51:08 INFO - 2015-11-06 05:51:08,745 DEBUG : process_Request line: dromaeo_css 5713.66 graph.html#tests=[[72,63,57]] 05:51:08 INFO - 2015-11-06 05:51:08,745 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:08 INFO - 2015-11-06 05:51:08,775 DEBUG : process_Request line: kraken 1835.40 graph.html#tests=[[232,63,57]] 05:51:08 INFO - 2015-11-06 05:51:08,775 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:08 INFO - 2015-11-06 05:51:08,810 DEBUG : process_Request line: v8_7 16435.33 graph.html#tests=[[230,63,57]] 05:51:08 INFO - 2015-11-06 05:51:08,811 INFO : javascript benchmark 05:51:08 INFO - 2015-11-06 05:51:08,813 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [284.2694275711423, 286.68178322062505, 291.0, 291.40407865914204, 295.0852357691157, 13912.373943172557, 14549.490767823128, 15014.474493392734, 15190.164540950258, 16097.275622596982, 15182.240887955613, 15207.771883421758, 15551.755859531238, 15608.219589020531, 15727.449539266128, 4327.610515053644, 4539.909201815962, 4544.886377840564, 4547.317902314646, 4564.8174073037035, 4529.8641040768825, 4584.633229341644, 4601.608863246628, 4605.746683932382, 4654.975905300828, 3383.5939687237565, 4558.179527685015, 4586.1974154522995, 4868.634852386068, 4956.752162391884, 4602.010567727954, 4829.7102173869325, 4830.637702172316, 4889.3399391082285, 4901.460839307673, 3211.1329940916057, 3292.37444885471, 4288.1638080573985, 4304.268274393361, 4305.9569404306185, 10740.946295268552, 10854.185936054748, 11032.062274706659, 11053.392063436508, 11230.719232019183, 1596.5449846793608, 1605.3979757590903, 1627.9987807498421, 1678.261564911435, 1695.4489790818034, 7796.337311328544, 7957.164497727771, 7998.800029999238, 8071.152528984489, 8214.1375155609, 1297.7209899871573, 1326.6152815683536, 1334.2994927663055, 1339.163023110556, 1359.8368195816468, 47995.76002120002, 49583.50416495825, 49813.75093124547, 50230.0, 50561.24158137631, 5305.787768489217, 5314.601404894648, 5399.217113518596, 5428.077226871442, 5450.5367043800925, 6075.453209211192, 6085.9695701521205, 6158.630482171084, 6167.660778657128, 6170.598911070766, 4472.9552704472535, 4555.794989225493, 4607.516210797818, 4615.5845973862515, 4616.376789133424, 4915.336429581961, 4928.728919909439, 4943.90112197754, 4995.975020124876, 5027.296178535008, 2410.529946660384, 2412.915547955813, 2417.9637305440433, 2438.963415548733, 2440.572899742538, 856.8586183279814, 861.2421069458961, 865.3682811547606, 872.1757938747949, 920.3557509743073, 322.81115547405034, 323.5744995331132, 358.89950813772185, 373.0487257493381, 383.844542960096, 9533.380330278509, 9817.214622830157, 9876.0, 9932.702018939442, 9972.052654997764, 384.45407521319237, 389.75055964182945, 392.75845355106975, 392.79770917977265, 414.8942019784935, 4998.500149984972, 5224.425313215544, 5270.859463656444, 5295.338082739658, 5366.651167674088, 472505.0, 477253.0, 487197.0, 490809.0, 495249.0, 56102.0, 57197.14204286856, 61268.0, 61569.0, 64898.67550662217, 408.78947342118835, 415.52007431416763, 419.492414178847, 420.66557087115814, 420.7349369896945, 8701.825963480822, 9037.909620903707, 9223.86164207524, 9261.814763704822, 9418.905810942077, 24450.75549244485, 28668.0, 29413.70586294195, 29511.26221844385, 31442.21394465157, 40489.59510404858, 40677.59322406738, 41112.0, 41219.58780412158, 41628.79185604052, 5102.770375333044, 5133.8716532087, 5156.922646160386, 5214.634975551675, 5216.191490318854, 9609.0, 9743.561539730586, 9790.461524616214, 9864.260180486635, 9887.950560247153, 8309.210624990616, 8370.623321950405, 8459.323254139777, 8555.61499732501, 8654.48073115615, 1897.5540747924504, 5041.437154482122, 6877.724891004304, 7913.208679132271, 8331.666733330841, 8191.590420478833, 8610.741677749678, 8615.655373784979, 8632.266257367943, 8671.132886711279, 4942.75286235694, 5075.0357432087785, 5082.974585127051, 5088.872778180576, 5154.690718556899, 8205.384596155192, 8401.369897257853, 8419.242268195892, 8496.532690701824, 8502.277306428776], "dojo.html": [2675.7458041486057, 2729.2085295264374, 2731.9863400682993, 2758.572421274702, 2820.534611789055, 4650.23271160259, 4676.134915040716, 4784.2345224764, 4795.784189711462, 4838.588719958799, 4531.592156705896, 4604.6776725629215, 4632.907341853161, 4666.533346665332, 4712.151812673717, 4409.1622591707555, 4430.9556904430865, 4470.0, 4494.460664720238, 4520.2315606347, 494.63649279338694, 4149.543550209474, 4359.803808828595, 4420.513743488214, 4496.482904465979, 4237.152569486084, 4318.978405107954, 4324.048709283952, 4352.303631418958, 4434.290513517822, 4320.027993701424, 4387.934180987288, 4398.3622374755805, 4445.177642136183, 4475.7985890635, 4191.015111448807, 4214.157168566299, 4350.303951367766, 4405.9118817623785, 4426.911461770779, 4436.268015777425, 4531.5921567058795, 4568.908621827578, 4620.422447194101, 4650.86047418578, 4902.068606964701, 4932.457429682732, 4981.975090124526, 4983.377077865267, 4983.825566105169, 4836.564709176191, 4958.0, 4982.327385802906, 5065.569426598743, 5083.288339632454, 4705.55297246761, 4710.576048155683, 4728.71627702339, 4729.763511824463, 4733.881652958704, 5098.821541246039, 5136.563392111712, 5138.794448222029, 5192.81825136126, 5205.0, 4712.528747125329, 4781.139394908881, 4786.114568804782, 4845.273209018605, 4846.055019271208, 4840.201366774513, 4971.1549036663855, 5032.572231360376, 5035.0685123252315, 5038.899222015539, 4893.6329775266995, 4909.852704418873, 4915.48387419323, 4968.22992436173, 4980.601551875841, 4886.291487734258, 4887.853364399002, 4952.331435256267, 4982.925256121089, 4989.3264409305, 3854.3062248795486, 3856.3829787234467, 3870.7871067091583, 3935.704822138351, 3936.389859571771, 3467.514547963287, 3494.1614012636783, 3518.6404164921187, 3541.3448512025357, 3545.8227088645463, 4351.26028575143, 4636.119137363958, 4676.602488788491, 4692.694974826625, 4707.152712511781, 4994.525520075587, 5072.137736584789, 5079.339685840817, 5091.439941606421, 5091.796328146833, 4639.327297541905, 4664.976675116603, 4702.623790096784, 4743.857684269477, 4767.427908650984, 4282.207791558571, 4332.480102387671, 4420.292753159479, 4437.445319335083, 4547.499775024745, 5127.615428842777, 5149.382074151126, 5165.096108181053, 5186.170212765939, 5200.323957885526, 5013.774380152829, 5053.191489361684, 5093.974530127474, 5117.411497677815, 5131.640785145004, 4937.382827146606, 5008.0735064011815, 5092.261622064706, 5223.085959956917, 5244.396894357045, 4814.662973591815, 4825.782839772289, 4906.950930490792, 4923.458419573915, 4931.50684931504, 4780.498047704941, 4876.902461950812, 4985.376827896513, 5026.070177017264, 5073.467285935071, 4665.0, 4879.170541008109, 4893.21708526634, 4943.604511639132, 4960.528749768766, 4892.559669629751, 4899.828506002273, 4925.014997000542, 4930.112579735682, 4932.556069953722, 4580.770961451981, 4645.2103142465185, 4663.370444990019, 4668.836590719445, 4817.229243321051, 4721.480637129982, 4883.8290659826735, 4885.169521181479, 4899.387576552931, 4938.678985865908, 4766.428028636586, 4788.545088216614, 4814.614830813456, 4824.95175048245, 4825.324454576292], "mootools.html": [1142.879997600252, 1195.3126952002594, 1198.820176973454, 1537.8462153784617, 1562.6015366081647, 5850.765969361226, 5926.170336152936, 6024.126501657262, 6251.187345645059, 6364.649944253064, 6897.206821215562, 7039.577625342483, 7096.112985876765, 7166.068411106562, 7176.964115179417, 1935.4677463697456, 1980.3761815028292, 1980.6137803128395, 2008.086320724067, 2011.7988201179912, 2001.419588319393, 2032.5629989552244, 2047.8464115191346, 2056.7429071366078, 2062.102985201435, 1938.3603410874448, 1972.566035472201, 1983.4644645945586, 2007.7791442941266, 2013.2852837242715, 1979.346815550872, 1981.5739615982634, 2004.929827456032, 2012.788657191003, 2013.2550956146247, 1931.893745843978, 1968.507873031742, 1975.9209631614717, 2021.20162535799, 2033.3391647714552, 7187.389071928892, 7189.352958233784, 7252.093488313961, 7254.492185546961, 7295.161056478467, 4272.786360681954, 4336.132773445323, 4368.257396242647, 4391.49497807753, 4410.338449232609, 2259.412552736284, 2307.3654744945106, 2498.1880888711244, 2540.8221424500293, 2572.704139023999, 772.2933515833063, 814.4705941138249, 820.9671613135467, 1335.71282174332, 1385.681293302546, 9506.334556581041, 9613.567389467491, 9684.51577421126, 9756.365836220622, 9756.365836220693, 3588.1567831559564, 3599.6400359963795, 3696.7966761828357, 3697.8335974881193, 3732.552093748713, 7270.236625154388, 7275.345218930216, 7304.452166087564, 7353.1911489736085, 7361.411087113018, 4116.608922152451, 4158.355454904495, 4217.240896638635, 4221.598948099926, 4224.471941007374, 3862.1503269280715, 3873.3996230584303, 3921.568627450978, 3921.6666583340734, 3930.7445016074435, 2986.4176485585103, 2995.8202507849164, 3006.2334104803135, 3030.9545356819667, 3035.9241018974703, 915.496476937695, 935.9110884465965, 936.1855185988234, 937.9953100234455, 941.6374695742188, 921.9723408297762, 938.5307346326837, 1128.480898786551, 1128.4865386249237, 1132.2017977325966, 6614.536982411185, 6755.324467553205, 6782.050512928194, 6862.4853136014, 6867.313268673092, 387.5775404808772, 387.77702820877545, 389.6804620211456, 390.2273498472983, 390.9179072394772, 5214.84355469329, 5284.101702710548, 5284.154535274338, 5368.946310536923, 5389.407165211824, 7778.611069446505, 7959.562224077731, 8489.702860399857, 8543.572821358906, 8615.741527754177, 8495.660173592987, 8504.744857654281, 8520.0, 8584.785380365542, 8592.0, 6535.640539770358, 6610.206775186912, 6695.531312808154, 6729.596224226562, 6796.15048118995, 6703.664816759045, 6730.293319201609, 6737.157855268091, 6742.9662851685425, 6746.898796517958, 7352.191258961617, 7683.346915512244, 7761.573113478587, 7810.0, 7812.0, 7603.695852165852, 7806.726764563213, 7811.296983271533, 7813.453058285865, 7849.411294152847, 5964.0, 6013.338532761305, 6029.352643673604, 6092.543059270483, 6109.75560977556, 6482.805515834532, 6491.935080649133, 6548.901766473411, 6553.4101930826455, 6565.343465653396, 6026.789062382795, 6126.908096378469, 6171.47542458896, 6220.129181914445, 6234.314225435108, 5979.073243647242, 6046.969765151146, 6068.150458935665, 6106.603070800384, 6126.663033533198, 6112.541559383153, 6187.195664563758, 6201.255849298113, 6211.9068213977735, 6230.59501132425, 5598.552115830806, 5639.915401269066, 5642.23829782974, 5647.915281270866, 5652.886942261214, 5336.466353364788, 5376.758045888023, 5407.324084489439, 5433.130699088285, 5454.236406903116], "ext.html": [485.94168699756034, 489.4884845336623, 506.099143524526, 506.93156423882766, 521.5749164430988, 33994.830025849864, 35143.648563514354, 35246.8237658812, 35287.4706879397, 35351.4697279541, 36351.0, 37876.81061594695, 37905.81047094761, 37919.62080379196, 37922.81038594803, 7727.884081738778, 7871.055473343178, 7985.520868747864, 8001.599920004006, 8018.318442932357, 7797.532148071134, 7854.057513098436, 7959.044914610255, 7963.163867793885, 7966.561839098877, 7713.498622589514, 7926.6829326826855, 7941.642626081812, 7943.483673561229, 7949.562774047425, 7749.845003099935, 7862.331701805296, 7937.920620793776, 7952.244536768998, 7956.403269754763, 7689.577073261024, 7701.614919254071, 7703.961480192619, 7811.296983271533, 7817.413693972975, 34213.31573368519, 34302.31395372078, 34753.82623086894, 34783.65216347829, 34784.0, 2171.4028642123385, 2344.5310937812337, 2476.2571228631336, 2665.1071890916373, 2712.7016028236876, 23481.060757569678, 23878.164264250667, 23976.88011559931, 24049.639255411184, 24141.15505957283, 1996.8502362322884, 2022.4135000849735, 2031.4560933690354, 2032.7865574114653, 2045.5602045560277, 216565.0, 217641.0, 218632.0, 220403.0, 220620.0, 50762.74618626883, 51016.489835101915, 51365.486345136815, 51384.486155138715, 51453.742731286104, 61728.0, 62158.37841621526, 62915.0, 62998.68500657468, 63072.36927630665, 14266.3580138894, 14467.49363772263, 14474.710505790035, 14556.126632402089, 14641.194734289504, 11059.889401106047, 11097.0, 11123.944380278046, 11153.888461115284, 11265.324080555192, 16775.15473297936, 17855.464336069937, 17900.373486927896, 17932.641347172983, 18134.90932545329, 7257.927420725725, 7534.736284230025, 7557.4331925105835, 7565.962170189114, 7568.480656494757, 778.3345239819986, 796.6016991504248, 818.7380038387658, 828.2131974624131, 918.7335672654855, 24744.505109898062, 25176.24471265865, 25194.0, 25200.117995870056, 25247.873760631446, 901.486152892858, 961.1445813226235, 980.1913421427352, 985.930984831055, 1016.6746641074785, 12919.547815826401, 13042.41309141091, 13085.542006029744, 13144.868551314556, 13157.67105822343, 252940.0, 256860.0, 257126.0, 261171.0, 261907.0, 47243.29135062977, 47859.042819143426, 47866.28200576994, 48385.0, 48532.0, 1187.4359679152506, 1194.898433633151, 1198.7302856857136, 1204.072863894796, 1208.709909621702, 24314.784260787244, 24353.269401917973, 24425.877870611243, 24715.62926556139, 24843.627345590194, 41785.373219401125, 41813.58186418218, 42304.0, 42361.364579531946, 42879.3568096485, 239550.0, 240232.0, 240537.0, 240812.0, 242377.0, 27873.0, 36412.27175456529, 37857.43213851739, 37950.62049379581, 38024.23951520899, 34994.650053499136, 35016.299674006885, 35668.64331356757, 40327.0, 43075.13849722925, 32929.50605740868, 34902.248362491584, 35094.12264693403, 35186.648133518334, 35740.28519429649, 31147.221319467193, 31518.36963260768, 31769.0, 31886.202844928135, 32112.591555633888, 32100.197495061875, 32490.83754581212, 34287.82856085704, 35588.644113558534, 35634.82182589071, 26144.738552614992, 28218.85890570534, 28279.858600706866, 28392.574111387934, 28940.131796046153, 21085.0, 21242.468938276666, 21249.787502124782, 21281.148754049664, 21288.25491107804], "prototype.html": [270.2406238469899, 272.4075136577943, 278.57934518876493, 279.1945237988403, 280.6253651375414, 5207.479252074791, 5329.813456529013, 5365.03429382711, 5401.081816091269, 5479.753411096501, 5154.793808247666, 5269.262303277545, 5275.788968441268, 5283.6037297202765, 5319.255304257407, 4082.4080508326274, 4098.4671992640915, 4138.648214901722, 4139.337705967046, 4139.523954745206, 4088.2232375848644, 4108.157827645326, 4127.360259159835, 4140.151268989865, 4150.0, 3948.565657777642, 4017.537983131948, 4054.8986275343204, 4109.671226301889, 4129.359949207877, 4043.8180281887385, 4056.371262454339, 4077.1845630873945, 4107.568705285947, 4116.547179810218, 3381.661833816623, 3453.0504111369323, 3458.0, 3466.0, 3484.407650699387, 5161.4322424533275, 5171.431142574352, 5176.637635365526, 5203.895922081575, 5228.346456692913, 4499.1451624191295, 4504.752238626874, 4507.098580283956, 4563.954360456386, 4581.1753884300815, 5414.10667239905, 5504.422035686275, 5517.0, 5561.443855614447, 5682.801101961453, 3668.853245870162, 3673.210259794157, 3683.2633473305445, 3713.3687273163355, 3730.2166545025575, 5780.277465316835, 5782.306123265235, 5807.186993820868, 5849.649021058707, 5872.500837428824, 3627.619099994515, 3653.9586217927763, 3711.9628803712158, 3730.309892669865, 3741.962580374216, 3589.246258285737, 3715.4241092630145, 3731.1418373774186, 3838.2899163654815, 3850.7882066486054, 4380.036391993756, 4427.490838553607, 4435.401220835146, 4438.400815889813, 4466.330050492387, 5537.778488860481, 5552.056150454432, 5556.833295001156, 5559.610827242135, 5599.60802743804, 1336.7994800779961, 1360.3674291454522, 1371.2937837013947, 1374.896882733799, 1377.7313423882447, 847.7965288330756, 858.7552547523926, 878.3236907581127, 879.7009016934273, 889.2663552569156, 5238.973805131026, 5284.07528682479, 5291.074062039128, 5308.601854860824, 5318.414974352818, 5754.108113242454, 5836.212111364996, 5849.210356601804, 5853.443922827325, 5859.912101318484, 5226.973865130726, 5302.019126461617, 5302.3637163540625, 5304.734763261821, 5305.389880163753, 3108.5492603572357, 3193.3134376109247, 3223.8065716057113, 3236.4336241157703, 3244.3024749678934, 5973.044312909914, 6000.159977603139, 6000.849978750479, 6002.0996850472775, 6004.729787159588, 5922.407759224043, 5948.583599148018, 5957.851053723692, 5967.403259673998, 5999.220101386792, 5899.616524925866, 5980.521558275327, 5982.0727787193055, 5991.370906054802, 6063.575549711478, 5808.5062769665055, 5819.621724587888, 5820.330661973927, 5860.531157507475, 5906.497947674324, 5715.914261286167, 5729.8567535811935, 5737.139429085671, 5778.595498315078, 5792.913106303325, 5997.820065398045, 6003.519718422428, 6010.849728756816, 6069.119977603311, 6089.54328425361, 3686.04162917638, 3693.464447655129, 3766.661000509858, 3768.5477742671055, 3778.9055273617278, 5561.443855614406, 5704.8003319885265, 5728.79949201776, 5730.541556675373, 5735.369109398046, 5517.200005999188, 5577.051901176891, 5581.330240371181, 5611.74747136388, 5683.403242659461, 5566.666000039849, 5571.9442805571425, 5606.2431571738925, 5644.181593668977, 5662.2639056922335, 5263.026340127089, 5439.184122381675, 5440.7551660174595, 5498.697571633598, 5528.115501519737, 5576.776928922797, 5642.774289028393, 5663.631863928831, 5688.260526131577, 5703.714814259188, 5509.256250406304, 5532.28080349552, 5549.861253468695, 5566.332040155207, 5607.495325420732], "yui.html": [558.5810642018486, 580.669018659364, 609.1806520230289, 634.2104080419876, 638.3190599482175, 11850.881491185086, 12154.270743755358, 12195.634130976085, 12205.023598112162, 12242.326672033047, 10939.726506837333, 11357.091432685385, 11412.885871141287, 11437.714057148554, 12037.638870833867, 743.8995735575683, 751.7819832248641, 757.5000499670218, 765.6401491299108, 766.8082979255187, 750.0511852506584, 751.2675141736818, 759.9734009309675, 760.5284723471427, 761.958092304923, 784.8194915169514, 788.7949133225345, 799.9120096789349, 800.8798680197988, 801.4309840013598, 782.8003859015943, 786.0057027859762, 789.5460110436522, 792.9643166057541, 792.9722459713911, 580.5094694982732, 584.1092334190394, 585.970701464925, 591.6686655472948, 592.4223881715336, 11656.59201927937, 11702.882971170264, 11811.114166437552, 11826.0, 11866.466009029615, 10063.496825158785, 10112.241581881315, 10240.129588984944, 10263.589456421734, 10693.78612427747, 7666.386689064917, 7882.80292992674, 7905.604719764046, 7959.204079592052, 7986.6805327786815, 2578.200757765099, 2620.6200100985443, 2694.420699549606, 2709.6612923384578, 2736.904208352698, 34576.48135277973, 35163.4725479118, 41364.759057228635, 41995.58004419947, 42926.35610465846, 5837.3870743571315, 5898.174255604219, 5910.704464776744, 5960.135780311917, 6128.908066379008, 10340.896591034143, 10386.740331491774, 10444.0, 10488.31825931312, 10549.103326217357, 5277.8416647500635, 5320.76056577455, 5331.946680533222, 5373.731313434391, 5478.0, 3117.5791268178505, 3159.5418664293547, 3252.4308246057317, 3288.0629020729457, 3381.594208694972, 2343.953120937572, 2377.9524409511714, 2378.345954862427, 2380.6071998120465, 2400.8079353652015, 341.95041718950614, 393.8877419935305, 402.32610377617374, 409.44724621760383, 415.4495293735812, 363.6835952721149, 439.86295426322675, 496.12096654642204, 528.8810017745976, 529.377980872481, 6378.840528986812, 6703.832404189934, 6745.932540674628, 6788.7284508619105, 6834.384905358542, 500.65955150498013, 509.4472497340427, 513.7482633509553, 529.282821776495, 531.6331731105524, 3403.846826892796, 3486.372452958441, 3535.646435356495, 3554.2809750540855, 3652.415613501827, 52730.0, 54287.0, 54422.72788636031, 54593.727031365386, 54600.72699636476, 47030.0, 47201.05597888023, 47333.0, 47793.52206477891, 47939.0, 39463.21073578512, 39893.202135957115, 40301.1939761209, 40814.183716325504, 42991.0, 6717.764878229434, 6972.926595813285, 7174.784756457315, 7292.416606671348, 7426.108866935786, 31273.8436307817, 31653.36693266168, 32521.349573007934, 32578.022659320257, 32636.83681581577, 39045.21909561849, 39079.60920390873, 39466.21067578575, 42873.0, 42920.0, 6481.189851268591, 6518.0, 6596.70314835824, 6633.005049242653, 6674.132362792806, 9396.295277854326, 9543.713688589354, 9611.183049440597, 9701.514924253901, 10312.587496500057, 8629.83940563217, 8702.390832641655, 8844.513551754715, 8996.190342869173, 9084.091590840862, 8570.4000719949, 8760.167784060504, 8886.822263554823, 8906.287497000354, 9014.233790127913, 8262.0, 8883.555822208993, 8926.419782714103, 9259.35184537076, 9274.814503709753, 7471.140818805907, 7809.180036096128, 7981.241782030698, 8083.797905052421, 8119.350451963711, 7161.85676286461, 7708.768736937901, 7716.961415192888, 7939.682412703427, 7955.164707705608]}, "summary": {"lowerIsBetter": false, "suite": 5713.6641318847605, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5692.547313206746, "unit": "ms", "value": 5692.547313206746}, "dojo.html": {"lowerIsBetter": false, "filtered": 4593.916842117627, "unit": "ms", "value": 4593.916842117627}, "mootools.html": {"lowerIsBetter": false, "filtered": 3861.1944684583746, "unit": "ms", "value": 3861.1944684583746}, "ext.html": {"lowerIsBetter": false, "filtered": 16220.75400363992, "unit": "ms", "value": 16220.75400363992}, "prototype.html": {"lowerIsBetter": false, "filtered": 4175.142583481029, "unit": "ms", "value": 4175.142583481029}, "yui.html": {"lowerIsBetter": false, "filtered": 5087.34333148801, "unit": "ms", "value": 5087.34333148801}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1446816653, "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": "20151106033934", "branch": "Mozilla-Inbound", "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232"}}, {"talos_counters": {}, "results": {"audio-dft": [191.0, 201.0, 209.0, 203.0, 201.0, 196.0, 193.0, 200.0, 206.0, 197.0], "ai-astar": [127.0, 125.0, 132.0, 131.0, 127.0, 139.0, 133.0, 135.0, 133.0, 128.0], "imaging-gaussian-blur": [150.0, 141.0, 143.0, 151.0, 150.0, 137.0, 143.0, 143.0, 136.0, 143.0], "audio-beat-detection": [178.0, 163.0, 183.0, 195.0, 155.0, 179.0, 178.0, 157.0, 189.0, 158.0], "json-stringify-tinderbox": [78.0, 81.0, 84.0, 84.0, 83.0, 85.0, 81.0, 80.0, 81.0, 80.0], "stanford-crypto-pbkdf2": [171.0, 191.0, 193.0, 188.0, 183.0, 176.0, 191.0, 193.0, 186.0, 185.0], "json-parse-financial": [70.0, 72.0, 75.0, 78.0, 77.0, 76.0, 76.0, 83.0, 75.0, 75.0], "stanford-crypto-sha256-iterative": [80.0, 83.0, 87.0, 91.0, 89.0, 84.0, 92.0, 86.0, 88.0, 88.0], "audio-fft": [82.0, 87.0, 100.0, 145.0, 80.0, 86.0, 82.0, 80.0, 116.0, 80.0], "imaging-darkroom": [157.0, 157.0, 148.0, 157.0, 156.0, 150.0, 158.0, 156.0, 149.0, 157.0], "stanford-crypto-ccm": [159.0, 165.0, 162.0, 152.0, 156.0, 151.0, 149.0, 156.0, 153.0, 164.0], "audio-oscillator": [105.0, 109.0, 151.0, 106.0, 110.0, 109.0, 143.0, 102.0, 110.0, 152.0], "stanford-crypto-aes": [103.0, 106.0, 107.0, 110.0, 108.0, 108.0, 109.0, 102.0, 103.0, 107.0], "imaging-desaturate": [121.0, 128.0, 127.0, 128.0, 126.0, 130.0, 127.0, 122.0, 128.0, 129.0]}, "summary": {"lowerIsBetter": true, "suite": 1835.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.8, "unit": "ms", "value": 93.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 185.7, "unit": "ms", "value": 185.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 173.5, "unit": "ms", "value": 173.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 156.7, "unit": "ms", "value": 156.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.5, "unit": "ms", "value": 154.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 75.7, "unit": "ms", "value": 75.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 119.7, "unit": "ms", "value": 119.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.0, "unit": "ms", "value": 131.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 199.7, "unit": "ms", "value": 199.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 81.7, "unit": "ms", "value": 81.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 106.3, "unit": "ms", "value": 106.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 126.6, "unit": "ms", "value": 126.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1446816653, "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": "20151106033934", "branch": "Mozilla-Inbound", "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232"}}, {"talos_counters": {}, "results": {"DeltaBlue": [242.306760358614], "Encrypt": [372.0238095238095], "NavierStokes": [6802.721088435374], "Decrypt": [6804.054054054054], "Splay": [775.7951900698216], "Richards": [193.53590090961873], "RegExp": [33900.0], "Earley": [1047.071129707113], "Boyer": [14779.411764705883], "RayTrace": [1333.3333333333333]}, "summary": {"lowerIsBetter": false, "suite": 16435.326789977087, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 272.86898599999995, "unit": "score", "value": 272.86898599999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 715.4945280000001, "unit": "score", "value": 715.4945280000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 218.1480000000001, "unit": "score", "value": 218.1480000000001}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.12094141012911, "unit": "score", "value": 39.12094141012911}, "Splay": {"lowerIsBetter": false, "filtered": 105.04189899999996, "unit": "score", "value": 105.04189899999996}, "RegExp": {"lowerIsBetter": false, "filtered": 26.872713864306778, "unit": "score", "value": 26.872713864306778}, "Richards": {"lowerIsBetter": false, "filtered": 182.40543399999996, "unit": "score", "value": 182.40543399999996}, "Earley": {"lowerIsBetter": false, "filtered": 636.5021258741261, "unit": "score", "value": 636.5021258741261}, "Boyer": {"lowerIsBetter": false, "filtered": 45.09401393034823, "unit": "score", "value": 45.09401393034823}, "RayTrace": {"lowerIsBetter": false, "filtered": 554.9917500000001, "unit": "score", "value": 554.9917500000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1446816653, "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": "20151106033934", "branch": "Mozilla-Inbound", "revision": "7964a5a4b0bd914d82822c9b1bb38dea19f90232"}}] 05:51:08 INFO - RETURN: dromaeo_css: 5713.66 05:51:08 INFO - RETURN: kraken: 1835.40 05:51:08 INFO - RETURN: v8_7: 16435.33 05:51:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "16435.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1835.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5713.66"}}} 05:51:08 INFO - Return code: 0 05:51:08 INFO - # TBPL SUCCESS # 05:51:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:08 INFO - 2015-11-06 05:51:08.942 screenresolution[1979:19243] starting screenresolution argv=screenresolution get 05:51:08 INFO - 2015-11-06 05:51:08.946 screenresolution[1979:19243] Display 0: 1600x1200x32@60 05:51:08 INFO - 2015-11-06 05:51:08.953 screenresolution[1980:19246] starting screenresolution argv=screenresolution list 05:51:08 INFO - Available Modes on Display 0 05:51:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:09 INFO - Intel HD Graphics 3000: 05:51:09 INFO - Chipset Model: Intel HD Graphics 3000 05:51:09 INFO - Type: GPU 05:51:09 INFO - Bus: Built-In 05:51:09 INFO - VRAM (Total): 512 MB 05:51:09 INFO - VRAM (Dynamic, Max): 10 05:51:09 INFO - Vendor: Intel (0x8086) 05:51:09 INFO - Device ID: 0x0116 05:51:09 INFO - Revision ID: 0x0009 05:51:09 INFO - Displays: 05:51:09 INFO - Display: 05:51:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:09 INFO - Display Serial Number: 1600x1200 60 05:51:09 INFO - Main Display: Yes 05:51:09 INFO - Mirror: Off 05:51:09 INFO - Online: Yes 05:51:09 INFO - Rotation: Supported 05:51:09 INFO - Return code: 0 05:51:09 INFO - Running post-action listener: _resource_record_post_action 05:51:09 INFO - Running post-run listener: _resource_record_post_run 05:51:10 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 602112; Write bytes: 690319360; Read time: 356; Write time: 72059 05:51:10 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 336491008; Write bytes: 334452736; Read time: 36133; Write time: 6864 05:51:10 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 602112; Write bytes: 345511936; Read time: 356; Write time: 64452 05:51:10 INFO - Running post-run listener: _upload_blobber_files 05:51:10 INFO - Blob upload gear active. 05:51:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:51:10 INFO - Copying logs to upload dir... 05:51:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.898559 ========= master_lag: 2.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-06 05:51:12.692965) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:51:12.696945) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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/WS_mO155Tne8g4qaG2O8GQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010402 build_url: 'https://queue.taskcluster.net/v1/task/WS_mO155Tne8g4qaG2O8GQ/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-06 05:51:12.724431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:51:12.724826) ========= 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.AgsxWkDhOl/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.TNBrw5qf94/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.005506 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:51:12.774964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:51:12.775323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:51:12.775771) ========= ========= Total master_lag: 2.71 =========