builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0034 starttime: 1449074946.73 results: success (0) buildid: 20151202071122 builduid: 74d9424fa5264d23828c467d0d4fae2d revision: bd29d7c987b554842ccee62dad4dec506e98227e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.726413) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.726850) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.727130) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.005969 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.780457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.780771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.992996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:06.993398) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.027533 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:07.042665) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:07.042967) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:07.043414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 08:49:07.043745) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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-12-02 08:49:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-12-02 08:49:07 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148893 ========= master_lag: 1.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 08:49:08.717556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-12-02 08:49:08.720498) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.162350 ========= master_lag: 3.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-12-02 08:49:11.969165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:11.969627) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd29d7c987b554842ccee62dad4dec506e98227e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd29d7c987b554842ccee62dad4dec506e98227e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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-12-02 08:49:12,065 truncating revision to first 12 chars 2015-12-02 08:49:12,065 Setting DEBUG logging. 2015-12-02 08:49:12,066 attempt 1/10 2015-12-02 08:49:12,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bd29d7c987b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 08:49:12,611 unpacking tar archive at: mozilla-aurora-bd29d7c987b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:12.834753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:12.835052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:12.842993) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:12.843243) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:12.843613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-12-02 08:49:12.843887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49:13 INFO - MultiFileLogger online at 20151202 08:49:13 in /builds/slave/test 08:49:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:49:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:13 INFO - {'append_to_log': False, 08:49:13 INFO - 'base_work_dir': '/builds/slave/test', 08:49:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:49:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:13 INFO - 'branch': 'Mozilla-Aurora', 08:49:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:13 INFO - 'config_files': ('talos/mac_config.py',), 08:49:13 INFO - 'default_actions': ('clobber', 08:49:13 INFO - 'read-buildbot-config', 08:49:13 INFO - 'download-and-extract', 08:49:13 INFO - 'populate-webroot', 08:49:13 INFO - 'create-virtualenv', 08:49:13 INFO - 'install', 08:49:13 INFO - 'run-tests'), 08:49:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:13 INFO - 'download_minidump_stackwalk': True, 08:49:13 INFO - 'download_symbols': 'ondemand', 08:49:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:13 INFO - 'installer_path': 'installer.exe', 08:49:13 INFO - 'log_level': 'info', 08:49:13 INFO - 'log_name': 'talos', 08:49:13 INFO - 'log_to_console': True, 08:49:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:13 INFO - 'opt_config_files': (), 08:49:13 INFO - 'pip_index': False, 08:49:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:13 INFO - 'cmd': ('bash', 08:49:13 INFO - '-c', 08:49:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:13 INFO - 'enabled': True, 08:49:13 INFO - 'halt_on_failure': False, 08:49:13 INFO - 'name': 'check_screen_resolution'},), 08:49:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:13 INFO - 'cmd': ('bash', 08:49:13 INFO - '-c', 08:49:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:13 INFO - 'enabled': True, 08:49:13 INFO - 'halt_on_failure': False, 08:49:13 INFO - 'name': 'check_screen_resolution'},), 08:49:13 INFO - 'run_cmd_checks_enabled': True, 08:49:13 INFO - 'sps_profile': False, 08:49:13 INFO - 'sps_profile_interval': 0, 08:49:13 INFO - 'suite': 'dromaeojs', 08:49:13 INFO - 'system_bits': '64', 08:49:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:13 INFO - 'title': 't-yosemite-r5-0034', 08:49:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:13 INFO - 'use_talos_json': True, 08:49:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:13 INFO - 'work_dir': 'build'} 08:49:13 INFO - ##### 08:49:13 INFO - ##### Running clobber step. 08:49:13 INFO - ##### 08:49:13 INFO - Running pre-action listener: _resource_record_pre_action 08:49:13 INFO - Running main action method: clobber 08:49:13 INFO - rmtree: /builds/slave/test/build 08:49:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:18 INFO - Running post-action listener: _resource_record_post_action 08:49:18 INFO - ##### 08:49:18 INFO - ##### Running read-buildbot-config step. 08:49:18 INFO - ##### 08:49:18 INFO - Running pre-action listener: _resource_record_pre_action 08:49:18 INFO - Running main action method: read_buildbot_config 08:49:18 INFO - Using buildbot properties: 08:49:18 INFO - { 08:49:18 INFO - "properties": { 08:49:18 INFO - "buildnumber": 445, 08:49:18 INFO - "product": "firefox", 08:49:18 INFO - "script_repo_revision": "production", 08:49:18 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 08:49:18 INFO - "repository": "", 08:49:18 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 08:49:18 INFO - "buildid": "20151202071122", 08:49:18 INFO - "slavename": "t-yosemite-r5-0034", 08:49:18 INFO - "pgo_build": "False", 08:49:18 INFO - "basedir": "/builds/slave/test", 08:49:18 INFO - "project": "", 08:49:18 INFO - "platform": "yosemite", 08:49:18 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:49:18 INFO - "slavebuilddir": "test", 08:49:18 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:49:18 INFO - "branch": "mozilla-aurora", 08:49:18 INFO - "repo_path": "releases/mozilla-aurora", 08:49:18 INFO - "stage_platform": "macosx64", 08:49:18 INFO - "builduid": "74d9424fa5264d23828c467d0d4fae2d", 08:49:18 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:49:18 INFO - }, 08:49:18 INFO - "sourcestamp": { 08:49:18 INFO - "repository": "", 08:49:18 INFO - "hasPatch": false, 08:49:18 INFO - "project": "", 08:49:18 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:49:18 INFO - "changes": [ 08:49:18 INFO - { 08:49:18 INFO - "category": null, 08:49:18 INFO - "files": [ 08:49:18 INFO - { 08:49:18 INFO - "url": null, 08:49:18 INFO - "name": "https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:49:18 INFO - } 08:49:18 INFO - ], 08:49:18 INFO - "repository": "", 08:49:18 INFO - "rev": "bd29d7c987b554842ccee62dad4dec506e98227e", 08:49:18 INFO - "who": "cbook@mozilla.com", 08:49:18 INFO - "when": 1449074282, 08:49:18 INFO - "number": 6733502, 08:49:18 INFO - "comments": "Bug 1224100 - Initialize row buffer to 0 in Downscaler - r=seth, a=lizzard", 08:49:18 INFO - "project": "", 08:49:18 INFO - "at": "Wed 02 Dec 2015 08:38:02", 08:49:18 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:49:18 INFO - "revlink": "", 08:49:18 INFO - "properties": [ 08:49:18 INFO - [ 08:49:18 INFO - "buildid", 08:49:18 INFO - "20151202071122", 08:49:18 INFO - "Change" 08:49:18 INFO - ], 08:49:18 INFO - [ 08:49:18 INFO - "builduid", 08:49:18 INFO - "74d9424fa5264d23828c467d0d4fae2d", 08:49:18 INFO - "Change" 08:49:18 INFO - ], 08:49:18 INFO - [ 08:49:18 INFO - "pgo_build", 08:49:18 INFO - "False", 08:49:18 INFO - "Change" 08:49:18 INFO - ] 08:49:18 INFO - ], 08:49:18 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:49:18 INFO - } 08:49:18 INFO - ], 08:49:18 INFO - "revision": "bd29d7c987b554842ccee62dad4dec506e98227e" 08:49:18 INFO - } 08:49:18 INFO - } 08:49:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:49:18 INFO - Running post-action listener: _resource_record_post_action 08:49:18 INFO - ##### 08:49:18 INFO - ##### Running download-and-extract step. 08:49:18 INFO - ##### 08:49:18 INFO - Running pre-action listener: _resource_record_pre_action 08:49:18 INFO - Running main action method: download_and_extract 08:49:18 INFO - mkdir: /builds/slave/test/build/tests 08:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:18 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json 08:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json 08:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:49:18 INFO - Downloaded 1149 bytes. 08:49:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:49:18 INFO - Using the following test package requirements: 08:49:18 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:49:18 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:49:18 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'jsshell-mac.zip'], 08:49:18 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:49:18 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:49:18 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:49:18 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:49:18 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:49:18 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:49:18 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:49:18 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:49:18 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:18 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:19 INFO - Downloaded 17490149 bytes. 08:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:49:25 INFO - Return code: 0 08:49:25 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:25 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:26 INFO - Downloaded 17490149 bytes. 08:49:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:49:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:49:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:49:31 INFO - Return code: 0 08:49: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')]} 08:49:31 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:49:32 INFO - Downloaded 11131307 bytes. 08:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 08:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:49:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:49:33 INFO - Return code: 0 08:49: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')]} 08:49:33 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 08:49:36 INFO - Downloaded 108652001 bytes. 08:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:49:36 INFO - mkdir: /builds/slave/test/properties 08:49:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:36 INFO - Contents: 08:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:49:36 INFO - Running post-action listener: _resource_record_post_action 08:49:36 INFO - Running post-action listener: set_extra_try_arguments 08:49:36 INFO - ##### 08:49:36 INFO - ##### Running populate-webroot step. 08:49:36 INFO - ##### 08:49:36 INFO - Running pre-action listener: _resource_record_pre_action 08:49:36 INFO - Running main action method: populate_webroot 08:49:36 INFO - Guessing talos json url... 08:49:36 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')]} 08:49:36 INFO - https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:49:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:49:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:49:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 08:49:37 INFO - Downloaded 107 bytes. 08:49:37 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:49:37 INFO - Contents: 08:49:37 INFO - 20151202071122 08:49:37 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/bd29d7c987b554842ccee62dad4dec506e98227e 08:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:37 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json 08:49:37 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bd29d7c987/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:49:37 INFO - Downloaded 4264 bytes. 08:49:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:37 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:49:37 INFO - '../fennec_ids.txt'], 08:49:37 INFO - 'tests': ['tcheck2']}, 08:49:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:37 INFO - '--tppagecycles', 08:49:37 INFO - '7'], 08:49:37 INFO - 'tests': ['tsvgm']}}, 08:49:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:49:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:49:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:49:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'tests': ['damp', 'tps']}, 08:49:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['damp', 'tps']}, 08:49:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:49:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:37 INFO - 'other': {'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'other_l64': {'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'other_nol64': {'tests': ['a11yr', 08:49:37 INFO - 'ts_paint', 08:49:37 INFO - 'tpaint', 08:49:37 INFO - 'sessionrestore', 08:49:37 INFO - 'sessionrestore_no_auto_restore']}, 08:49:37 INFO - 'svgr': {'tests': ['tsvgx', 08:49:37 INFO - 'tsvgr_opacity', 08:49:37 INFO - 'tart', 08:49:37 INFO - 'tscrollx', 08:49:37 INFO - 'cart']}, 08:49:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['tsvgx', 08:49:37 INFO - 'tsvgr_opacity', 08:49:37 INFO - 'tart', 08:49:37 INFO - 'tscrollx', 08:49:37 INFO - 'cart']}, 08:49:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'tests': ['tp5o']}, 08:49:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'talos_options': ['--e10s'], 08:49:37 INFO - 'tests': ['tp5o']}, 08:49:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'talos_options': ['--xperf_path', 08:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:37 INFO - 'tests': ['tp5n']}, 08:49:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:37 INFO - 'talos_options': ['--e10s', 08:49:37 INFO - '--xperf_path', 08:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:49:37 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:49:37 INFO - 'tests': ['tp5n']}}, 08:49:37 INFO - 'talos.zip': {'path': '', 08:49:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:37 INFO - Running post-action listener: _resource_record_post_action 08:49:37 INFO - ##### 08:49:37 INFO - ##### Running create-virtualenv step. 08:49:37 INFO - ##### 08:49:37 INFO - Running pre-action listener: _resource_record_pre_action 08:49:37 INFO - Running main action method: create_virtualenv 08:49:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:37 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 08:49:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:37 INFO - Using real prefix '/tools/python27' 08:49:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:42 INFO - Installing pip.................done. 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:42 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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:42 INFO - 'HOME': '/Users/cltbld', 08:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PAGER': '/bin/cat', 08:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:49:42 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - 'XPC_FLAGS': '0x0', 08:49:42 INFO - 'XPC_SERVICE_NAME': '0', 08:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:43 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 08:49:43 INFO - Cleaning up... 08:49:43 INFO - Return code: 0 08:49:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:49:43 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')]} 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 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')]} 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49:43 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 08:49:43 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 08:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:43 INFO - 'HOME': '/Users/cltbld', 08:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:43 INFO - 'LOGNAME': 'cltbld', 08:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:43 INFO - 'MOZ_NO_REMOTE': '1', 08:49:43 INFO - 'NO_EM_RESTART': '1', 08:49:43 INFO - 'PAGER': '/bin/cat', 08:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:43 INFO - 'PWD': '/builds/slave/test', 08:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:43 INFO - 'SHELL': '/bin/bash', 08:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:49:43 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:43 INFO - 'USER': 'cltbld', 08:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:43 INFO - 'XPC_FLAGS': '0x0', 08:49:43 INFO - 'XPC_SERVICE_NAME': '0', 08:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:43 INFO - Downloading/unpacking psutil>=0.7.1 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:49:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:46 INFO - Installing collected packages: psutil 08:49:46 INFO - Running setup.py install for psutil 08:49:46 INFO - building 'psutil._psutil_osx' extension 08:49:46 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 08:49: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 08:49: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 08:49: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 08:49:49 INFO - building 'psutil._psutil_posix' extension 08:49:49 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 08:49:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:49:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:49:49 INFO - ^ 08:49:49 INFO - 1 warning generated. 08:49: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 08:49:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:49 INFO - Successfully installed psutil 08:49:49 INFO - Cleaning up... 08:49:49 INFO - Return code: 0 08:49:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49: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 08:49: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 08:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:49 INFO - 'HOME': '/Users/cltbld', 08:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:49 INFO - 'LOGNAME': 'cltbld', 08:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:49 INFO - 'MOZ_NO_REMOTE': '1', 08:49:49 INFO - 'NO_EM_RESTART': '1', 08:49:49 INFO - 'PAGER': '/bin/cat', 08:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:49 INFO - 'PWD': '/builds/slave/test', 08:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:49 INFO - 'SHELL': '/bin/bash', 08:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:49:49 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:49 INFO - 'USER': 'cltbld', 08:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:49 INFO - 'XPC_FLAGS': '0x0', 08:49:49 INFO - 'XPC_SERVICE_NAME': '0', 08:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:49:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49: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) 08:49:52 INFO - Installing collected packages: mozsystemmonitor 08:49:52 INFO - Running setup.py install for mozsystemmonitor 08:49:52 INFO - Successfully installed mozsystemmonitor 08:49:52 INFO - Cleaning up... 08:49:52 INFO - Return code: 0 08:49:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49: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 08:49: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 08:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:52 INFO - 'HOME': '/Users/cltbld', 08:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:52 INFO - 'LOGNAME': 'cltbld', 08:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:52 INFO - 'MOZ_NO_REMOTE': '1', 08:49:52 INFO - 'NO_EM_RESTART': '1', 08:49:52 INFO - 'PAGER': '/bin/cat', 08:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:52 INFO - 'PWD': '/builds/slave/test', 08:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:52 INFO - 'SHELL': '/bin/bash', 08:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:49:52 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:52 INFO - 'USER': 'cltbld', 08:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:52 INFO - 'XPC_FLAGS': '0x0', 08:49:52 INFO - 'XPC_SERVICE_NAME': '0', 08:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:57 INFO - Downloading docopt-0.6.1.tar.gz 08:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:57 INFO - Running setup.py install for blobuploader 08:49:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:57 INFO - Running setup.py install for requests 08:49:57 INFO - Running setup.py install for docopt 08:49:58 INFO - Successfully installed blobuploader requests docopt 08:49:58 INFO - Cleaning up... 08:49:58 INFO - Return code: 0 08:49:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:49: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 08:49: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 08:49:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:49:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:58 INFO - 'HOME': '/Users/cltbld', 08:49:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:58 INFO - 'LOGNAME': 'cltbld', 08:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:58 INFO - 'MOZ_NO_REMOTE': '1', 08:49:58 INFO - 'NO_EM_RESTART': '1', 08:49:58 INFO - 'PAGER': '/bin/cat', 08:49:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:58 INFO - 'PWD': '/builds/slave/test', 08:49:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:58 INFO - 'SHELL': '/bin/bash', 08:49:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:49:58 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:49:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:58 INFO - 'USER': 'cltbld', 08:49:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:58 INFO - 'XPC_FLAGS': '0x0', 08:49:58 INFO - 'XPC_SERVICE_NAME': '0', 08:49:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:58 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-kfAP0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:58 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-UD_wJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:58 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-waHeo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:58 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-JoQqZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-3J60aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-GnasyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-nbHQOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-bXaY42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-_9ykUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-7FEEFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:59 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-SGMNg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Z21Tl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-VgN1eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-xHj53r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-rUM2PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-LCRwHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:00 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-FTqpxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:00 INFO - Running setup.py install for manifestparser 08:50:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:00 INFO - Running setup.py install for mozcrash 08:50:01 INFO - Running setup.py install for mozdebug 08:50:01 INFO - Running setup.py install for mozdevice 08:50:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:01 INFO - Running setup.py install for mozfile 08:50:01 INFO - Running setup.py install for mozhttpd 08:50:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:01 INFO - Running setup.py install for mozinfo 08:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Running setup.py install for mozInstall 08:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Running setup.py install for mozleak 08:50:02 INFO - Running setup.py install for mozlog 08:50:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Running setup.py install for moznetwork 08:50:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:02 INFO - Running setup.py install for mozprocess 08:50:03 INFO - Running setup.py install for mozprofile 08:50:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:03 INFO - Running setup.py install for mozrunner 08:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:03 INFO - Running setup.py install for mozscreenshot 08:50:03 INFO - Running setup.py install for moztest 08:50:03 INFO - Running setup.py install for mozversion 08:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:04 INFO - Cleaning up... 08:50:04 INFO - Return code: 0 08:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:50: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 08:50: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 08:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:04 INFO - 'HOME': '/Users/cltbld', 08:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:04 INFO - 'LOGNAME': 'cltbld', 08:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:04 INFO - 'MOZ_NO_REMOTE': '1', 08:50:04 INFO - 'NO_EM_RESTART': '1', 08:50:04 INFO - 'PAGER': '/bin/cat', 08:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:04 INFO - 'PWD': '/builds/slave/test', 08:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:04 INFO - 'SHELL': '/bin/bash', 08:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:50:04 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:04 INFO - 'USER': 'cltbld', 08:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:04 INFO - 'XPC_FLAGS': '0x0', 08:50:04 INFO - 'XPC_SERVICE_NAME': '0', 08:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:04 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-a3E1Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50: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)) 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:04 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-IZSW44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50: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)) 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:04 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-dr__1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50: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)) 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:04 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-CBH4u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 08:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:04 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-CLhVlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50: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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-MmZR5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50: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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-eafemX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-itzeL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50: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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-npNZBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50: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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Ug4g48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50: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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-AxsLw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:05 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)) 08:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:05 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-eocI0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50: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)) 08:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:06 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-R1ZdCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50: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)) 08:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:06 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-GBwrjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50: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)) 08:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:06 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-9BOFwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50: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)) 08:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:06 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-sRcenj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50: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)) 08:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:06 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-wMJCFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50: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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:09 INFO - Downloading blessings-1.5.1.tar.gz 08:50: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 08:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:09 INFO - Installing collected packages: blessings 08:50:09 INFO - Running setup.py install for blessings 08:50:09 INFO - Successfully installed blessings 08:50:09 INFO - Cleaning up... 08:50:09 INFO - Return code: 0 08:50:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:10 INFO - Reading from file tmpfile_stdout 08:50:10 INFO - Current package versions: 08:50:10 INFO - blessings == 1.5.1 08:50:10 INFO - blobuploader == 1.2.4 08:50:10 INFO - docopt == 0.6.1 08:50:10 INFO - manifestparser == 1.1 08:50:10 INFO - mozInstall == 1.12 08:50:10 INFO - mozcrash == 0.16 08:50:10 INFO - mozdebug == 0.1 08:50:10 INFO - mozdevice == 0.46 08:50:10 INFO - mozfile == 1.2 08:50:10 INFO - mozhttpd == 0.7 08:50:10 INFO - mozinfo == 0.8 08:50:10 INFO - mozleak == 0.1 08:50:10 INFO - mozlog == 3.0 08:50:10 INFO - moznetwork == 0.27 08:50:10 INFO - mozprocess == 0.22 08:50:10 INFO - mozprofile == 0.27 08:50:10 INFO - mozrunner == 6.11 08:50:10 INFO - mozscreenshot == 0.1 08:50:10 INFO - mozsystemmonitor == 0.0 08:50:10 INFO - moztest == 0.7 08:50:10 INFO - mozversion == 1.4 08:50:10 INFO - psutil == 3.1.1 08:50:10 INFO - requests == 1.2.3 08:50:10 INFO - wsgiref == 0.1.2 08:50:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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 0x1102eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362cf8cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, '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.IVnTccHjbj/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.0MXDNXL7QS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 08:50: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 08:50: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 08:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:10 INFO - 'HOME': '/Users/cltbld', 08:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:10 INFO - 'LOGNAME': 'cltbld', 08:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:10 INFO - 'MOZ_NO_REMOTE': '1', 08:50:10 INFO - 'NO_EM_RESTART': '1', 08:50:10 INFO - 'PAGER': '/bin/cat', 08:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:10 INFO - 'PWD': '/builds/slave/test', 08:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:10 INFO - 'SHELL': '/bin/bash', 08:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:50:10 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:10 INFO - 'USER': 'cltbld', 08:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:10 INFO - 'XPC_FLAGS': '0x0', 08:50:10 INFO - 'XPC_SERVICE_NAME': '0', 08:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50:10 INFO - Cleaning up... 08:50:10 INFO - Return code: 0 08:50:10 INFO - Running post-action listener: _resource_record_post_action 08:50:10 INFO - Running post-action listener: _start_resource_monitoring 08:50:10 INFO - Starting resource monitoring. 08:50:10 INFO - ##### 08:50:10 INFO - ##### Running install step. 08:50:10 INFO - ##### 08:50:10 INFO - Running pre-action listener: _resource_record_pre_action 08:50:10 INFO - Running main action method: install 08:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:10 INFO - Reading from file tmpfile_stdout 08:50:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:11 INFO - Reading from file tmpfile_stdout 08:50:11 INFO - Output received: 08:50:11 INFO - Usage: mozinstall [options] installer 08:50:11 INFO - Options: 08:50:11 INFO - -h, --help show this help message and exit 08:50:11 INFO - -d DEST, --destination=DEST 08:50:11 INFO - Directory to install application into. [default: 08:50:11 INFO - "/builds/slave/test"] 08:50:11 INFO - --app=APP Application being installed. [default: firefox] 08:50:11 INFO - mkdir: /builds/slave/test/build/application 08:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:51 INFO - Reading from file tmpfile_stdout 08:50:51 INFO - Output received: 08:50:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:50:51 INFO - Running post-action listener: _resource_record_post_action 08:50:51 INFO - ##### 08:50:51 INFO - ##### Running run-tests step. 08:50:51 INFO - ##### 08:50:51 INFO - Running pre-action listener: _resource_record_pre_action 08:50:51 INFO - Running main action method: run_tests 08:50:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:51 INFO - 2015-12-02 08:50:51.152 screenresolution[1629:7549] starting screenresolution argv=screenresolution get 08:50:51 INFO - 2015-12-02 08:50:51.156 screenresolution[1629:7549] Display 0: 1600x1200x32@60 08:50:51 INFO - 2015-12-02 08:50:51.163 screenresolution[1630:7551] starting screenresolution argv=screenresolution list 08:50:51 INFO - Available Modes on Display 0 08:50:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:51 INFO - Intel HD Graphics 3000: 08:50:51 INFO - Chipset Model: Intel HD Graphics 3000 08:50:51 INFO - Type: GPU 08:50:51 INFO - Bus: Built-In 08:50:51 INFO - VRAM (Total): 512 MB 08:50:51 INFO - VRAM (Dynamic, Max): 10 08:50:51 INFO - Vendor: Intel (0x8086) 08:50:51 INFO - Device ID: 0x0116 08:50:51 INFO - Revision ID: 0x0009 08:50:51 INFO - Displays: 08:50:51 INFO - Display: 08:50:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:51 INFO - Display Serial Number: 1600x1200 60 08:50:51 INFO - Main Display: Yes 08:50:51 INFO - Mirror: Off 08:50:51 INFO - Online: Yes 08:50:51 INFO - Rotation: Supported 08:50:51 INFO - Return code: 0 08:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:51 INFO - Python 2.7.3 08:50:51 INFO - Return code: 0 08:50:51 INFO - grabbing minidump binary from tooltool 08:50:51 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')]} 08:50:51 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 0x1102a29f0>, '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 0x110001cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11026c990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:51 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 08:50:51 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 08:50:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:51 INFO - Return code: 0 08:50:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] in /builds/slave/test/build 08:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0034 --webServer localhost 08:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IVnTccHjbj/Render', 08:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:51 INFO - 'HOME': '/Users/cltbld', 08:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:51 INFO - 'LOGNAME': 'cltbld', 08:50:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:51 INFO - 'MOZ_NO_REMOTE': '1', 08:50:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:51 INFO - 'NO_EM_RESTART': '1', 08:50:51 INFO - 'PAGER': '/bin/cat', 08:50:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:51 INFO - 'PWD': '/builds/slave/test', 08:50:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:51 INFO - 'SHELL': '/bin/bash', 08:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0MXDNXL7QS/Listeners', 08:50:51 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 08:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:51 INFO - 'USER': 'cltbld', 08:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:51 INFO - 'XPC_FLAGS': '0x0', 08:50:51 INFO - 'XPC_SERVICE_NAME': '0', 08:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:50:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] with output_timeout 3600 08:50:51 INFO - mozversion INFO | application_buildid: 20151202071122 08:50:51 INFO - mozversion INFO | application_changeset: bd29d7c987b554842ccee62dad4dec506e98227e 08:50:51 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:50:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:51 INFO - mozversion INFO | application_name: Firefox 08:50:51 INFO - mozversion INFO | application_remotingname: firefox-dev 08:50:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:51 INFO - mozversion INFO | application_vendor: Mozilla 08:50:51 INFO - mozversion INFO | application_version: 44.0a2 08:50:51 INFO - mozversion INFO | platform_buildid: 20151202071122 08:50:51 INFO - mozversion INFO | platform_changeset: bd29d7c987b554842ccee62dad4dec506e98227e 08:50:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:51 INFO - mozversion INFO | platform_version: 44.0a2 08:50:51 INFO - 2015-12-02 08:50:51,902 DEBUG : using testdate: 1449075051 08:50:51 INFO - 2015-12-02 08:50:51,902 DEBUG : actual date: 1449075051 08:50:51 INFO - 2015-12-02 08:50:51,915 INFO : starting webserver on 'localhost:49288' 08:50:51 INFO - 2015-12-02 08:50:51,916 INFO : Starting test suite t-yosemite-r5-0034 08:50:51 INFO - 2015-12-02 08:50:51,916 INFO : Starting test dromaeo_css 08:50:51 INFO - 2015-12-02 08:50:51,916 DEBUG : operating with platform_type : mac_ 08:50:51 INFO - 2015-12-02 08:50:51,917 INFO : Initialising browser for dromaeo_css test... 08:50:51 INFO - 2015-12-02 08:50:51,948 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpEv3dJx/profile http://localhost:49288/getInfo.html 08:50:54 INFO - 2015-12-02 08:50:54,907 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:50:54 INFO - 2015-12-02 08:50:54,907 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:50:54 INFO - 2015-12-02 08:50:54,907 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:50:54 INFO - 2015-12-02 08:50:54,907 DEBUG : BROWSER_OUTPUT: __metrics 08:50:54 INFO - 2015-12-02 08:50:54,923 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:55 INFO - 2015-12-02 08:50:55,635 INFO : Browser initialized. 08:50:55 INFO - 2015-12-02 08:50:55,635 INFO : Running cycle 1/1 for dromaeo_css test... 08:50:55 INFO - 2015-12-02 08:50:55,636 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpEv3dJx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:51:07 INFO - 2015-12-02 08:51:07,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 199593984 08:51:07 INFO - 2015-12-02 08:51:07,622 DEBUG : BROWSER_OUTPUT: 08:51:59 INFO - 2015-12-02 08:51:59,318 DEBUG : BROWSER_OUTPUT: 1449075119311 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] 08:54:09 INFO - 2015-12-02 08:54:09,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 08:54:11 INFO - 2015-12-02 08:54:11,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 323248128 08:54:11 INFO - 2015-12-02 08:54:11,177 DEBUG : BROWSER_OUTPUT: 08:57:13 INFO - 2015-12-02 08:57:13,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 08:57:14 INFO - 2015-12-02 08:57:14,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 345772032 08:57:14 INFO - 2015-12-02 08:57:14,527 DEBUG : BROWSER_OUTPUT: 09:00:16 INFO - 2015-12-02 09:00:16,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 09:00:17 INFO - 2015-12-02 09:00:17,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 316022784 09:00:17 INFO - 2015-12-02 09:00:17,332 DEBUG : BROWSER_OUTPUT: 09:03:19 INFO - 2015-12-02 09:03:19,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 09:03:19 INFO - 2015-12-02 09:03:19,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 302174208 09:03:19 INFO - 2015-12-02 09:03:19,985 DEBUG : BROWSER_OUTPUT: 09:06:23 INFO - 2015-12-02 09:06:23,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 09:06:23 INFO - 2015-12-02 09:06:23,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 302878720 09:06:23 INFO - 2015-12-02 09:06:23,634 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 09:09:26 INFO - 2015-12-02 09:09:26,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 348471296 09:09:26 INFO - 2015-12-02 09:09:26,557 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,557 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:09:26 INFO - 2015-12-02 09:09:26,557 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:09:26 INFO - 2015-12-02 09:09:26,557 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:09:26 INFO - 2015-12-02 09:09:26,557 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:09:26 INFO - 2015-12-02 09:09:26,558 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2813.1982385020265;2867.268846444156;2875.5255382861815;2926.6634337051237;2927.2974486123326;4801.6398770092255;4861.7812198451065;4864.805407783689;4896.632752543555;4909.729964851932;4722.38608980832;4822.686525375857;4903.289023091649;4905.2396878483805;4910.926336104962;4327.372530983005;4437.4896886858105;4442.289233722605;4488.910221795562;4500.639948804088;4497.685162038659;4509.77451127444;4510.751908645039;4531.184386810372;4563.406757121586;4393.780310984438;4495.1459222747735;4499.595036446719;4521.050579378334;4530.864074077766;4248.766317852533;4386.385905973167;4398.736075835428;4431.202383570956;4440.800163992628;4406.867793966187;4448.8442904498515;4475.910481790378;4479.888002799924;4542.409486766732;4583.060472603109;4656.95343046572;4720.527947205286;4723.244280915037;4802.084317400987;5129.538341549279;5203.297554830087;5232.450592687751;5238.554722848562;5243.737813109367;5231.215317702337;5263.236830659571;5269;5277.788888444457;5278.2082687596785;4680.321353403806;4720.362751028636;4779.808807647724;4793.49668284832;4926.45808961014;5279.788808447619;5285.233641122016;5293.179557168645;5330.866728331745;5356.0626890294825;4934.8766280843265;5000.374953130859;5040.218766091261;5043.495650435;5059.165237735806;4966.528179822911;5066.16408292635;5074.340335756402;5101.2603172539775;5181.740912954413;5032.3206367139965;5048.116579598555;5063.87340316495;5066.290719299301;5155.587552995751;5007.47421520735;5058.190689489664;5099.286099946011;5102.285680004802;5120.692758434506;3715.9442608360896;3867.5165604299464;3950.150717595731;3992;4018.678505719535;3602.2615363850346;3604.3512167810045;3627.3289441453417;3627.4921510988484;3687.9631203688155;4785.784639691222;4834.371531700926;4856.247281671346;4860.635452341018;4867.683600565952;4925.21196608541;5025.623078269145;5050.141475949097;5080.822171223989;5237.790488380422;4768.332433459318;4770.618350532019;4777.331173635694;4801.351817504662;4823.348847905488;4408.493023302297;4493.146302202636;4494.752788596658;4497.965467942392;4535.342375355555;4968.602511799119;5074.898502030012;5096.566791822588;5207.062728708793;5239.161734122522;5273.736313184402;5274.393444753749;5284.577233821208;5287.365516138088;5307;5277.551408130352;5279.47205279469;5318.042752304622;5342.065138600807;5394.083005889087;4954.925676114789;4977.552020318189;5018.4981501849525;5099.209622508517;5234.2672025915645;5243.8164664236565;5245.659032162897;5278.023565640369;5301.1783173608155;5310.256564081109;5060;5079.44126146131;5102.948970510248;5142.851436503338;5190.455002224712;4704.200285951465;5005.524475174852;5091.745412729423;5097.286379906742;5137.1010073237785;4987.700737955734;4988.775505102351;4992.650514463952;5002.849914502571;5029;5115.2582875483595;5143.665661731976;5205.245239440335;5206.687598744087;5210;4722.598579120813;4769.594584460221;4889.9022019560125;4938.506149385176;4948.62885283598 09:09:26 INFO - 2015-12-02 09:09:26,559 DEBUG : BROWSER_OUTPUT: |1;ext.html;502.78882869194933;506.8682142642914;510.0513045734932;515.296620113545;541.90245755764;28183;29604.85197574012;35234.47148292778;36108;36142.638573614255;38072.80963595185;38665.806670966675;38675.22649547007;38708.80645596768;39370.803145984304;7647;8326.292265157468;8331.416800823945;8376.49741015538;8452.28155606774;7634.083909930816;9820.36167649104;10008.049235322633;10022.398656080659;10082.74793130174;9009.864852027225;9792.363496372749;9850.310478266489;9853.162481189107;9866.260030497706;7720.305172534443;7877.36981041521;9685.564149613285;9810.65662701802;9883.406995580252;9663.082007209305;9700.466474343908;9809.21526277896;9820.508974551316;9952.402855828674;35288.64711352905;35355.82322088399;35535.28929421423;35725.46411803825;35878.64121358805;2463.1132792194794;2533.2526904563015;2569.1008147148536;2738.9178324650093;2919.5182794838825;24648.753512464824;24842.130525431523;25013.62479562808;25036.624450633255;25278.115265965786;2047.5495391013953;2095.3399679101035;2131;2136.2416342198453;2145.10977944153;236917;237302;237762;239869.80065099738;240523;53264.46735532595;53854;54062.45937540574;54223.72888135534;54632;49175.508244917095;51267.743661281456;61158;63719.36280637227;64121.679391602745;15318.463853765064;15354.769678454832;15369.001014933994;15398.46105386306;15416.691666166615;11505.079593632488;11508.769824603462;11509.366984815748;11681.941590292165;11694.181407301578;17440.5639859002;17675;17787.73318400225;17801.7329740054;17865.642687146184;7548.849023019508;7788.805279868048;7827.45207835446;7956.443048986631;7969.402294827911;863.48622569571;899.9955000224957;973.7808992976666;1009.5053423822275;1037.056278786316;25222.49555008926;25650.102246421287;25888.482230355665;25996.22011339663;26034.479310413684;887.272436601993;893.2675206330877;982.3761911186448;991.2565575818137;994.8656931314325;12153.574624888086;12673.17624354414;12699.428525716365;12725.045621578418;12886.09797314179;293206;300809;303347;303844;305852;42125;43160.78419607882;47692.52307476881;49447;50106.49893501091;1222.437678667805;1229.7540491901834;1242.1305086439347;1267.9175853569488;1298.7532368849888;21059.684104738746;23078.884605576866;23808;24617.261482155565;24619.507609847344;39868.2026359477;40332.59667403289;40336.79831600823;40783.592164079164;40996.59003410047;226996;228202;232537;234272;236874;26488.8675556621;26528;27062.594061089494;27079.458410831277;27133.86433067822;36501.81749091238;36569.63430365769;36919;37528.437073443376;37905.62094379021;30513.38973220479;30982.380352393277;31067.68932310648;31112.844435777675;31243;30285.394292114474;30517.694823051486;30665.846670767394;30766.384672306875;30789;32207.838960805046;32424.675753243107;32622.83688581542;32788.344233115684;32842.343153136324;24093.879530602935;24695;26694.733052670003;28841.85579072175;29789.10632681023;20698.793012069687;21042.3682862162;22215.888920555295;22515;22813.885930570243 09:09:26 INFO - 2015-12-02 09:09:26,561 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.9630847989761;294.79511739341154;310.5931230088584;310.65982748889957;317.65534395181226;13325.333733313344;13567.660808479768;15393.846061539381;15455.22723863808;15558.922205388986;13768.24274664893;15925.601859953507;15967;16184.75722864155;16371.91814040931;4522.276435770269;4586.97706511467;4708.317293992369;4726.858194254178;4782.306565547993;3567.1795487038;3645.270945810835;3678.2275722098393;4554.134714404253;4609.7234165949985;4916.3608730864935;4968.378952630921;5055.671381360218;5091.847244582668;5143.562797162227;4980.800767969277;5059.848204553851;5084.415292241384;5147.6654017488745;5186.766595503212;4522.8643140705835;4524.796384162721;4530.07133537624;4531.048479819242;4557.658175636808;11256.831147532794;19317.323893663794;19464;19519;19699.310524131586;1548.4128768012877;1690.3745614122731;1699.337258469198;1751.9778382290574;1778.386456672446;8427.073021967579;8527.701530446404;8731.476111433334;8755.518446485441;8774.254188393994;1295.5012320256674;1317.9538716144984;1382.2259534660523;1401.4254155796177;1437.7987081808556;51291.743541282056;53561.732191339186;54058;54384.18423723687;55034.72482637601;5807.738651760681;5811.099279611667;5892.705364731746;5936.37668044849;6076.75692972285;6793.116894803644;6889.931100689029;6891.793246202622;6909.792706218822;6926.030355750199;4889.43538067822;4976.377952755905;4993.875153121128;5094.439611642716;5096.439391666913;5378.166384210375;5385.7307134643115;5388.865278368072;5433.809816656398;5437.755301011464;2658.189252278035;2667.026535314596;2675.478281735082;2677.7857771378244;2703.378223008719;926.2451102351562;935.6818681648273;975.9947254328054;994.5822754443151;1000.099910080933;388.6366247558542;395.5470985721333;412.72759978414103;421.02952694040533;427.6087380047284;10337.22470814692;10515.263931524873;10619.787604247871;10632.840507392395;10855.131589472823;364.6845478660939;392.22731219497547;395.67752281890165;405.15120821878116;408.2202992284781;5386.91919621206;5622.437756224426;5784.59507834456;5797.826065218051;5833.7083145842535;476190;476364;480412;487342;509568;62853.37146628475;65015.67492162509;65645.34354656392;66115.66942165258;66629;403;411.5164681499226;414.64340667026335;415.70069549924006;417.2635298697801;9704.223662107155;9796.65711700087;9882.209423245979;9918.156956658764;10023.398596084258;31708;32106.357872841945;32334.19164520906;32401.837990809894;32870.506942396365;42622;42819.57180428156;43482.78258608687;43513;44052.11895762003;5134.204198349262;5211.895762084813;5229.6339256251695;5262.947370526399;5317.548008419328;9665.565049572926;9710.805783884141;9793.755156121155;9806.26453016041;9867.851982220129;7688.538687678757;7866.016747906512;7891.84216315682;8153.592320383838;8652.740417787476;7933.563653999086;8135.877961830695;8330;8812.515311657664;8915.153060459246;8497.787555311166;8976.685815996409;9244.722658320261;9249.676261330822;9262;5534.1145416733125;5594.328680558359;5660.20757093999;5701.4298570142655;5762.654240745569;7643.656035478306;9003.488639430758;9073.77315567116;9157.49633770149;9197.172254497127 09:09:26 INFO - 2015-12-02 09:09:26,564 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1143.605456117639;1523.9771403428947;1591.108978971776;1599.8800089993247;1610.2914717524295;5755.136729490573;6147.13940048393;6295.937040629592;6423.775167869126;6493.220813502375;6167.691615419233;6375.776847810327;6387.936120638792;6391.744330226797;6435.452986496141;1867.5237814357354;1868.4955062133215;1874.1940965384879;1898.9335373261938;1904.6857268550673;1919.7137917595244;1920.1263425141526;1946.9610607787836;1953.8534609904243;1968.3406058970263;1870.3827736846877;1877.8873267603988;1880.2385034061226;1888.7166924961298;1892.0350621183159;1807.4848668129587;1810.1039985207276;1817.5365281853176;1823.4529641107747;1830.7916774928617;1882.2471011595471;1888.8205620466172;1900.4583693647244;1905.8761180523222;1919.587288732915;5817.476427121537;6386;6437.678116094176;6439.098526206335;6440.033994900802;3568.2506673598577;3939.468171796799;4035.9192816143805;4067.2272268268935;4130.0500884796365;2377.976220237793;2420.552197843387;2422.2854257993936;2429.0526694589125;2432.586460301753;744.2743325257884;753.6420200404818;770.3952397368096;780.8906753054576;790.6679194738224;8395.580220988988;8397.034341050796;8420.157984201593;8464.619092140807;8518.446300990478;3526.559180102487;3569.696575791035;3654.3056819204267;3690.151265209017;3698.0754811297174;7437.776866694008;7458.105027396748;7496.100467943882;7551.244875512405;7573.242675732493;4078.8164532596106;4098.979505102515;4121.608447197512;4154.148399578079;4167.312393455046;3747.737658363943;3749.8125093745202;3767.4913886625504;3774.207416442523;3800.733948623625;2997.565353023843;3017;3036.878524858981;3094.535819627074;3123.515855042472;952.3619175152526;954.4225743425128;961.7884065505577;975.7999610079917;986.5807032011367;890.8841850559386;922.0733163171104;1140.885911408869;1186.3771519951922;1188.7979043562616;6072.119542666289;6096.207493025879;6133.96933015341;6143.723532440961;6167;989;995.0845222395413;1014.1481155829139;1029.5161274201114;1034.1726618705006;5036.597072234213;5079.187330027178;5084.542391184811;5106.795728170906;5114.360704911886;7158.319959603829;7297.927020729831;7510.061242344707;7565.508241964255;7603.885941710879;7526.435517336222;7566.956921631128;7586.658600362997;7648;7727.536347819037;6091.360407157274;6117.938820611826;6177.104319873683;6223.222097237845;6292.622442653547;6150.261968563801;6156.846078848064;6159.784407545714;6161.137440758208;6214;6915;6970.616616086164;6975.476839236976;7021.227664956748;7051.259617740268;6961.303869612998;7097.467689923174;7197.496175267681;7201.4238860889955;7213.134423869169;5561;5601.971990140023;5633.887322253614;5635;5652;6244.125822384961;6281.811545653638;6298.338674439118;6300.086487459201;6415.9358406417205;5877.853053673693;5890.528757699288;5930.406959304208;5959.553033522589;5963.13534537481;5708.400617935057;5784.566157538286;5795.710214489343;5825.3883342248455;5860.355360910382;5781.277340332458;5829.795957141479;5928.288605367384;5935.792247271324;5938.910916336172;5017.949820501748;5143.871403214949;5145.948540514697;5157.793688252578;5181.119209734279;5182.196759502283;5254.106801843619;5285.101532739367;5290.761915713879;5334.813281535127 09:09:26 INFO - 2015-12-02 09:09:26,565 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.4872855766783;294.8555207948106;297.5001996645635;298.3495978766289;299.85457053329145;5200.817971371002;5294.52349288564;5375.48932851379;5387.0841956867325;5451.3458384993855;5345.305110335661;5354.598405119612;5374.865628359293;5379.946200537994;5381.0852155133625;4108.650764684998;4139.648129908961;4146.336586146217;4158.2307273154565;4206.116715489736;4138.958610413887;4146.688998325122;4160.375943608453;4175.519815221242;4205.03284244624;3907.374820028796;4010.4786377770993;4110.403991421242;4125.587441255881;4129.463169787939;3992.7005474589378;4031.1937612477623;4035.8385664573384;4038.414429907676;4074.286999775057;3478.4608385700258;3480.564929383827;3494.2138018945534;3496.4930085137767;3499.5975462821593;5094.745262736848;5108.386993560759;5137.768800403954;5167.9224811627855;5219.973900130475;4492.797824097924;4568.086382723469;4612.423447069116;4633.791479383436;4642.373279607244;5455.781768729246;5582.692951887645;5638.943610563882;5659.207710920475;5675.404082571312;3801.6388443097862;3809.276237514863;3821.14024344523;3837.9040523986846;3847.9230415391535;5585.329760428734;5679.744411501492;5690.260266165414;5754.510866576346;5958.5828991970575;3777.187904600469;3814.6948244140403;3836.462895194675;3874.49631547897;3879.7866117363815;3894.8636797711943;3925.2738243425056;3929.7445666031617;3946.3685810270217;3954.62431069048;4344.239758042393;4452.532484089124;4498.6626003049905;4547.249703798902;4552.430946131733;5519.668819870741;5540.667559946416;5547.528460080938;5587.245721827582;5653.971730141323;1386.6117487103627;1403.3895255563862;1408.2747385096684;1414.0101928649985;1418.099506813181;857.7898414888392;881.5592203898051;883.0992387764444;885.9911400886037;916.9449833010041;5275.63070585063;5312.335958005249;5334.413214546396;5366.677999319975;5385.973070134624;5772.7113644317615;5773.566982476331;5810.912836307459;5822.214001109796;5862.853428664317;5324.946750532445;5351.625386223005;5364.839054828283;5380.542653874386;5382.596305277119;3114.5328200770064;3191.824449655291;3227.9193020174685;3235.902922912316;3283;5905.173275741399;5905.734241959036;5905.852353691193;5942.10868369748;5963.910541341883;5953.79161729346;5974.701264936736;5990.5507086968655;5994.880102397928;6047.123167140828;5823.039198532364;5842.678652674143;5881.382454842265;5902.822915312633;5932.436418540232;5710.914336284876;5779.884402311846;5789.507891829242;5814.883702326015;5858.794942177004;5648.265725455664;5675.120356344773;5675.432456754292;5685.630434021941;5723.055695810144;5834.94165058344;5888.705564721661;5889.204957330877;5921.7631294747725;5942.970285148546;3667.449882517537;3822.7515211511163;3891.3579259421876;3897.8635747748694;3898.9220215596097;5550.8057217997175;5670.376258611467;5772.9711351442975;5802.593818432669;5807.448292412214;5522.6134170607675;5555.638883472561;5607.046802043581;5610.9158362623775;5622.381538030895;5603.159526071122;5612.354579223442;5633.63381380209;5637.718114094197;5692.516136128475;5144.382674078985;5251.422343542284;5478.479544443271;5487.807926722546;5495.368032676293;5550.7779688812;5567;5640.294963129609;5689.971550142222;5704.771809127588;5518.2826232591115;5560.165975103767;5562.193481945176;5579.69311687861;5629.408912064175 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: |5;yui.html;603.6800495737259;668.1114118222764;670.3129292475211;674.4402146218639;677.9966100169498;10949.233553651247;11156.665300040991;11245.044171245434;11249.437528123592;11574.016208622277;11240;11624.535018599267;11767.823482647767;11787.764244715101;11833.29000259985;658.0951192110848;664.7307840324652;792.0614072324299;811.7118422959853;812.1188510466122;802.4182467710892;815.6207363575936;820.0897004325194;821.8972628421448;823.555280148722;839.0770152831867;850.9319254459659;855.6064210463195;855.7218903856271;857.1257317536141;671.2716702377926;681.8363592737708;832.6877420967137;840.4873027453249;850.8596081646521;622.6233128957007;630.4704048599153;633.5311869216793;636.4017823246134;640.9903851442232;11232.887671123266;11881.34652594107;12055.57805476804;12059.276443413422;12200;10253.948730256376;10315.1747860171;10359.482025898751;10554.313969592029;11166.832497512463;8028.638711258008;8318.168183181693;8409.663613455454;8424.620892059873;8461.83076338476;2974.7917645764805;3024.8185108893317;3046.299351149226;3074.8001379910233;3104.9068527944196;43466.34800477995;43781.56218437807;43806.34290485645;44005.77997109994;44083.55916440827;7781.182975787574;7937.603119843985;7962.800929976681;8008.039035315799;8104.918950810416;17551.473455796346;17567.912160439373;17574.38489652856;17604.647907041788;17791.73312400315;5137.922931156036;5225.5819534437915;5308.309919710413;5324.3078399808555;5415.8104466344275;3326.6507016763376;3409.113630456099;3409.5567576214935;3439.810810405452;3493.2664140530774;2385.976140238575;2412.662227288181;2413.975860241375;2417.758224177568;2433.683621129277;348.86045581767496;351.8698081709733;351.91905861651964;356.13814568743703;361.3369467028033;468.39343050749363;469.2351467108591;475.5767367043334;484.9960581596062;510.6399988008519;6241.687915604201;6320.8419789504715;6324.051392291101;6531.934680653228;6556.213254409406;485.09771824406573;491.74675042353215;505.31782094172576;512.845997117729;513.1584201908872;2898.739113479755;3033.5904652872023;3060.9540856887165;3067.92330191747;3170.651228364878;50627;54002.18996715052;54601.45398545964;54914.17628735572;54990;47142.5285747145;47247;47516;47841.5215847844;47846;40569;41002.1799564007;41595.37606935899;42751.572484275384;42920.356194657106;6847.554908930903;7037.296270372922;7103.289671032855;7154.892676609751;7370.852582948418;31997.36005279928;32775;32970.340593188484;33092.1726956828;33411;39210.60789392069;39336.803315983234;40392;41204.58795412008;42104;6377.808665740035;6578.703958321983;6724.4620430364475;6987.371136597731;7016.894746578703;9828.746055999978;9878.802423951336;9918.504074796087;9961.50192490387;10136.087752102347;9039.322050846082;9239.214666753402;9369.625214991323;9461.195798357217;9516.476593787409;9660.32377733552;9672.95163524206;9675.9032409675;9728.562214700214;9792.755181120529;8901.510416926872;9146.588403521724;9210.585523651318;9236.953815230881;9298.070192980647;7914.44598878073;8387.664493420194;8409.453385529921;8419.410641255054;8456.577171141542;7736.149023607286;8122;8175.305099066408;8352.540610266493;8398.664053438039 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:09:26 INFO - 2015-12-02 09:09:26,569 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076166554__endTimestamp 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4798.05 Median:4948.63 stddev:520.83 (10.5%) stddev-sans-first:498.61 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: Values: 2813.2 2867.3 2875.5 2926.7 2927.3 4801.6 4861.8 4864.8 4896.6 4909.7 4722.4 4822.7 4903.3 4905.2 4910.9 4327.4 4437.5 4442.3 4488.9 4500.6 4497.7 4509.8 4510.8 4531.2 4563.4 4393.8 4495.1 4499.6 4521.1 4530.9 4248.8 4386.4 4398.7 4431.2 4440.8 4406.9 4448.8 4475.9 4479.9 4542.4 4583.1 4657.0 4720.5 4723.2 4802.1 5129.5 5203.3 5232.5 5238.6 5243.7 5231.2 5263.2 5269.0 5277.8 5278.2 4680.3 4720.4 4779.8 4793.5 4926.5 5279.8 5285.2 5293.2 5330.9 5356.1 4934.9 5000.4 5040.2 5043.5 5059.2 4966.5 5066.2 5074.3 5101.3 5181.7 5032.3 5048.1 5063.9 5066.3 5155.6 5007.5 5058.2 5099.3 5102.3 5120.7 3715.9 3867.5 3950.2 3992.0 4018.7 3602.3 3604.4 3627.3 3627.5 3688.0 4785.8 4834.4 4856.2 4860.6 4867.7 4925.2 5025.6 5050.1 5080.8 5237.8 4768.3 4770.6 4777.3 4801.4 4823.3 4408.5 4493.1 4494.8 4498.0 4535.3 4968.6 5074.9 5096.6 5207.1 5239.2 5273.7 5274.4 5284.6 5287.4 5307.0 5277.6 5279.5 5318.0 5342.1 5394.1 4954.9 4977.6 5018.5 5099.2 5234.3 5243.8 5245.7 5278.0 5301.2 5310.3 5060.0 5079.4 5102.9 5142.9 5190.5 4704.2 5005.5 5091.7 5097.3 5137.1 4987.7 4988.8 4992.7 5002.8 5029.0 5115.3 5143.7 5205.2 5206.7 5210.0 4722.6 4769.6 4889.9 4938.5 4948.6 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,570 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41070.20 Median:30716.12 stddev:67721.05 (220.5%) stddev-sans-first:67842.53 09:09:26 INFO - 2015-12-02 09:09:26,572 DEBUG : BROWSER_OUTPUT: Values: 502.8 506.9 510.1 515.3 541.9 28183.0 29604.9 35234.5 36108.0 36142.6 38072.8 38665.8 38675.2 38708.8 39370.8 7647.0 8326.3 8331.4 8376.5 8452.3 7634.1 9820.4 10008.0 10022.4 10082.7 9009.9 9792.4 9850.3 9853.2 9866.3 7720.3 7877.4 9685.6 9810.7 9883.4 9663.1 9700.5 9809.2 9820.5 9952.4 35288.6 35355.8 35535.3 35725.5 35878.6 2463.1 2533.3 2569.1 2738.9 2919.5 24648.8 24842.1 25013.6 25036.6 25278.1 2047.5 2095.3 2131.0 2136.2 2145.1 236917.0 237302.0 237762.0 239869.8 240523.0 53264.5 53854.0 54062.5 54223.7 54632.0 49175.5 51267.7 61158.0 63719.4 64121.7 15318.5 15354.8 15369.0 15398.5 15416.7 11505.1 11508.8 11509.4 11681.9 11694.2 17440.6 17675.0 17787.7 17801.7 17865.6 7548.8 7788.8 7827.5 7956.4 7969.4 863.5 900.0 973.8 1009.5 1037.1 25222.5 25650.1 25888.5 25996.2 26034.5 887.3 893.3 982.4 991.3 994.9 12153.6 12673.2 12699.4 12725.0 12886.1 293206.0 300809.0 303347.0 303844.0 305852.0 42125.0 43160.8 47692.5 49447.0 50106.5 1222.4 1229.8 1242.1 1267.9 1298.8 21059.7 23078.9 23808.0 24617.3 24619.5 39868.2 40332.6 40336.8 40783.6 40996.6 226996.0 228202.0 232537.0 234272.0 236874.0 26488.9 26528.0 27062.6 27079.5 27133.9 36501.8 36569.6 36919.0 37528.4 37905.6 30513.4 30982.4 31067.7 31112.8 31243.0 30285.4 30517.7 30665.8 30766.4 30789.0 32207.8 32424.7 32622.8 32788.3 32842.3 24093.9 24695.0 26694.7 28841.9 29789.1 20698.8 21042.4 22215.9 22515.0 22813.9 09:09:26 INFO - 2015-12-02 09:09:26,572 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,572 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24254.55 Median:4987.34 stddev:79633.62 (1596.7%) stddev-sans-first:79836.67 09:09:26 INFO - 2015-12-02 09:09:26,574 DEBUG : BROWSER_OUTPUT: Values: 284.0 294.8 310.6 310.7 317.7 13325.3 13567.7 15393.8 15455.2 15558.9 13768.2 15925.6 15967.0 16184.8 16371.9 4522.3 4587.0 4708.3 4726.9 4782.3 3567.2 3645.3 3678.2 4554.1 4609.7 4916.4 4968.4 5055.7 5091.8 5143.6 4980.8 5059.8 5084.4 5147.7 5186.8 4522.9 4524.8 4530.1 4531.0 4557.7 11256.8 19317.3 19464.0 19519.0 19699.3 1548.4 1690.4 1699.3 1752.0 1778.4 8427.1 8527.7 8731.5 8755.5 8774.3 1295.5 1318.0 1382.2 1401.4 1437.8 51291.7 53561.7 54058.0 54384.2 55034.7 5807.7 5811.1 5892.7 5936.4 6076.8 6793.1 6889.9 6891.8 6909.8 6926.0 4889.4 4976.4 4993.9 5094.4 5096.4 5378.2 5385.7 5388.9 5433.8 5437.8 2658.2 2667.0 2675.5 2677.8 2703.4 926.2 935.7 976.0 994.6 1000.1 388.6 395.5 412.7 421.0 427.6 10337.2 10515.3 10619.8 10632.8 10855.1 364.7 392.2 395.7 405.2 408.2 5386.9 5622.4 5784.6 5797.8 5833.7 476190.0 476364.0 480412.0 487342.0 509568.0 62853.4 65015.7 65645.3 66115.7 66629.0 403.0 411.5 414.6 415.7 417.3 9704.2 9796.7 9882.2 9918.2 10023.4 31708.0 32106.4 32334.2 32401.8 32870.5 42622.0 42819.6 43482.8 43513.0 44052.1 5134.2 5211.9 5229.6 5262.9 5317.5 9665.6 9710.8 9793.8 9806.3 9867.9 7688.5 7866.0 7891.8 8153.6 8652.7 7933.6 8135.9 8330.0 8812.5 8915.2 8497.8 8976.7 9244.7 9249.7 9262.0 5534.1 5594.3 5660.2 5701.4 5762.7 7643.7 9003.5 9073.8 9157.5 9197.2 09:09:26 INFO - 2015-12-02 09:09:26,574 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,574 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4531.39 Median:5806.59 stddev:2287.51 (39.4%) stddev-sans-first:2279.75 09:09:26 INFO - 2015-12-02 09:09:26,576 DEBUG : BROWSER_OUTPUT: Values: 1143.6 1524.0 1591.1 1599.9 1610.3 5755.1 6147.1 6295.9 6423.8 6493.2 6167.7 6375.8 6387.9 6391.7 6435.5 1867.5 1868.5 1874.2 1898.9 1904.7 1919.7 1920.1 1947.0 1953.9 1968.3 1870.4 1877.9 1880.2 1888.7 1892.0 1807.5 1810.1 1817.5 1823.5 1830.8 1882.2 1888.8 1900.5 1905.9 1919.6 5817.5 6386.0 6437.7 6439.1 6440.0 3568.3 3939.5 4035.9 4067.2 4130.1 2378.0 2420.6 2422.3 2429.1 2432.6 744.3 753.6 770.4 780.9 790.7 8395.6 8397.0 8420.2 8464.6 8518.4 3526.6 3569.7 3654.3 3690.2 3698.1 7437.8 7458.1 7496.1 7551.2 7573.2 4078.8 4099.0 4121.6 4154.1 4167.3 3747.7 3749.8 3767.5 3774.2 3800.7 2997.6 3017.0 3036.9 3094.5 3123.5 952.4 954.4 961.8 975.8 986.6 890.9 922.1 1140.9 1186.4 1188.8 6072.1 6096.2 6134.0 6143.7 6167.0 989.0 995.1 1014.1 1029.5 1034.2 5036.6 5079.2 5084.5 5106.8 5114.4 7158.3 7297.9 7510.1 7565.5 7603.9 7526.4 7567.0 7586.7 7648.0 7727.5 6091.4 6117.9 6177.1 6223.2 6292.6 6150.3 6156.8 6159.8 6161.1 6214.0 6915.0 6970.6 6975.5 7021.2 7051.3 6961.3 7097.5 7197.5 7201.4 7213.1 5561.0 5602.0 5633.9 5635.0 5652.0 6244.1 6281.8 6298.3 6300.1 6415.9 5877.9 5890.5 5930.4 5959.6 5963.1 5708.4 5784.6 5795.7 5825.4 5860.4 5781.3 5829.8 5928.3 5935.8 5938.9 5017.9 5143.9 5145.9 5157.8 5181.1 5182.2 5254.1 5285.1 5290.8 5334.8 09:09:26 INFO - 2015-12-02 09:09:26,576 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,576 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4670.22 Median:5380.24 stddev:1414.28 (26.3%) stddev-sans-first:1379.37 09:09:26 INFO - 2015-12-02 09:09:26,576 DEBUG : BROWSER_OUTPUT: Values: 282.5 294.9 297.5 298.3 299.9 5200.8 5294.5 5375.5 5387.1 5451.3 5345.3 5354.6 5374.9 5379.9 5381.1 4108.7 4139.6 4146.3 4158.2 4206.1 4139.0 4146.7 4160.4 4175.5 4205.0 3907.4 4010.5 4110.4 4125.6 4129.5 3992.7 4031.2 4035.8 4038.4 4074.3 3478.5 3480.6 3494.2 3496.5 3499.6 5094.7 5108.4 5137.8 5167.9 5220.0 4492.8 4568.1 4612.4 4633.8 4642.4 5455.8 5582.7 5638.9 5659.2 5675.4 3801.6 3809.3 3821.1 3837.9 3847.9 5585.3 5679.7 5690.3 5754.5 5958.6 3777.2 3814.7 3836.5 3874.5 3879.8 3894.9 3925.3 3929.7 3946.4 3954.6 4344.2 4452.5 4498.7 4547.2 4552.4 5519.7 5540.7 5547.5 5587.2 5654.0 1386.6 1403.4 1408.3 1414.0 1418.1 857.8 881.6 883.1 886.0 916.9 5275.6 5312.3 5334.4 5366.7 5386.0 5772.7 5773.6 5810.9 5822.2 5862.9 5324.9 5351.6 5364.8 5380.5 5382.6 3114.5 3191.8 3227.9 3235.9 3283.0 5905.2 5905.7 5905.9 5942.1 5963.9 5953.8 5974.7 5990.6 5994.9 6047.1 5823.0 5842.7 5881.4 5902.8 5932.4 5710.9 5779.9 5789.5 5814.9 5858.8 5648.3 5675.1 5675.4 5685.6 5723.1 5834.9 5888.7 5889.2 5921.8 5943.0 3667.4 3822.8 3891.4 3897.9 3898.9 5550.8 5670.4 5773.0 5802.6 5807.4 5522.6 5555.6 5607.0 5610.9 5622.4 5603.2 5612.4 5633.6 5637.7 5692.5 5144.4 5251.4 5478.5 5487.8 5495.4 5550.8 5567.0 5640.3 5690.0 5704.8 5518.3 5560.2 5562.2 5579.7 5629.4 09:09:26 INFO - 2015-12-02 09:09:26,576 DEBUG : BROWSER_OUTPUT: 09:09:26 INFO - 2015-12-02 09:09:26,577 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12147.63 Median:29663.25 stddev:14846.60 (50.1%) stddev-sans-first:14862.94 09:09:26 INFO - 2015-12-02 09:09:26,578 DEBUG : BROWSER_OUTPUT: Values: 603.7 668.1 670.3 674.4 678.0 10949.2 11156.7 11245.0 11249.4 11574.0 11240.0 11624.5 11767.8 11787.8 11833.3 658.1 664.7 792.1 811.7 812.1 802.4 815.6 820.1 821.9 823.6 839.1 850.9 855.6 855.7 857.1 671.3 681.8 832.7 840.5 850.9 622.6 630.5 633.5 636.4 641.0 11232.9 11881.3 12055.6 12059.3 12200.0 10253.9 10315.2 10359.5 10554.3 11166.8 8028.6 8318.2 8409.7 8424.6 8461.8 2974.8 3024.8 3046.3 3074.8 3104.9 43466.3 43781.6 43806.3 44005.8 44083.6 7781.2 7937.6 7962.8 8008.0 8104.9 17551.5 17567.9 17574.4 17604.6 17791.7 5137.9 5225.6 5308.3 5324.3 5415.8 3326.7 3409.1 3409.6 3439.8 3493.3 2386.0 2412.7 2414.0 2417.8 2433.7 348.9 351.9 351.9 356.1 361.3 468.4 469.2 475.6 485.0 510.6 6241.7 6320.8 6324.1 6531.9 6556.2 485.1 491.7 505.3 512.8 513.2 2898.7 3033.6 3061.0 3067.9 3170.7 50627.0 54002.2 54601.5 54914.2 54990.0 47142.5 47247.0 47516.0 47841.5 47846.0 40569.0 41002.2 41595.4 42751.6 42920.4 6847.6 7037.3 7103.3 7154.9 7370.9 31997.4 32775.0 32970.3 33092.2 33411.0 39210.6 39336.8 40392.0 41204.6 42104.0 6377.8 6578.7 6724.5 6987.4 7016.9 9828.7 9878.8 9918.5 9961.5 10136.1 9039.3 9239.2 9369.6 9461.2 9516.5 9660.3 9673.0 9675.9 9728.6 9792.8 8901.5 9146.6 9210.6 9237.0 9298.1 7914.4 8387.7 8409.5 8419.4 8456.6 7736.1 8122.0 8175.3 8352.5 8398.7 09:09:26 INFO - 2015-12-02 09:09:26,579 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:09:26 INFO - 2015-12-02 09:09:26,579 DEBUG : BROWSER_OUTPUT: 09:09:27 INFO - 2015-12-02 09:09:27,281 INFO : Browser exited with error code: 0 09:09:27 INFO - 2015-12-02 09:09:27,314 INFO : Completed test dromaeo_css (00:18:35) 09:09:27 INFO - 2015-12-02 09:09:27,314 INFO : Starting test kraken 09:09:27 INFO - 2015-12-02 09:09:27,314 DEBUG : operating with platform_type : mac_ 09:09:27 INFO - 2015-12-02 09:09:27,314 INFO : Initialising browser for kraken test... 09:09:27 INFO - 2015-12-02 09:09:27,329 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpwO07KL/profile http://localhost:49288/getInfo.html 09:09:29 INFO - 2015-12-02 09:09:29,646 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:09:29 INFO - 2015-12-02 09:09:29,646 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:09:29 INFO - 2015-12-02 09:09:29,646 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:09:29 INFO - 2015-12-02 09:09:29,646 DEBUG : BROWSER_OUTPUT: __metrics 09:09:29 INFO - 2015-12-02 09:09:29,653 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:30 INFO - 2015-12-02 09:09:30,337 INFO : Browser initialized. 09:09:30 INFO - 2015-12-02 09:09:30,337 INFO : Running cycle 1/1 for kraken test... 09:09:30 INFO - 2015-12-02 09:09:30,338 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpwO07KL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:09:42 INFO - 2015-12-02 09:09:42,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 198701056 09:09:42 INFO - 2015-12-02 09:09:42,293 DEBUG : BROWSER_OUTPUT: 09:09:45 INFO - 2015-12-02 09:09:45,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:45 INFO - 2015-12-02 09:09:45,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 263548928 09:09:45 INFO - 2015-12-02 09:09:45,667 DEBUG : BROWSER_OUTPUT: 09:09:48 INFO - 2015-12-02 09:09:48,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 09:09:49 INFO - 2015-12-02 09:09:49,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 278773760 09:09:49 INFO - 2015-12-02 09:09:49,207 DEBUG : BROWSER_OUTPUT: 09:09:52 INFO - 2015-12-02 09:09:52,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 09:09:52 INFO - 2015-12-02 09:09:52,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 267055104 09:09:52 INFO - 2015-12-02 09:09:52,944 DEBUG : BROWSER_OUTPUT: 09:09:55 INFO - 2015-12-02 09:09:55,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 09:09:55 INFO - 2015-12-02 09:09:55,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 268148736 09:09:55 INFO - 2015-12-02 09:09:55,776 DEBUG : BROWSER_OUTPUT: 09:09:58 INFO - 2015-12-02 09:09:58,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:58 INFO - 2015-12-02 09:09:58,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 267841536 09:09:58 INFO - 2015-12-02 09:09:58,756 DEBUG : BROWSER_OUTPUT: 09:10:02 INFO - 2015-12-02 09:10:02,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:02 INFO - 2015-12-02 09:10:02,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 267587584 09:10:02 INFO - 2015-12-02 09:10:02,742 DEBUG : BROWSER_OUTPUT: 09:10:06 INFO - 2015-12-02 09:10:06,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:06 INFO - 2015-12-02 09:10:06,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 266391552 09:10:06 INFO - 2015-12-02 09:10:06,815 DEBUG : BROWSER_OUTPUT: 09:10:10 INFO - 2015-12-02 09:10:10,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 09:10:10 INFO - 2015-12-02 09:10:10,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 265736192 09:10:10 INFO - 2015-12-02 09:10:10,608 DEBUG : BROWSER_OUTPUT: 09:10:12 INFO - 2015-12-02 09:10:12,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:12 INFO - 2015-12-02 09:10:12,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 299298816 09:10:12 INFO - 2015-12-02 09:10:12,912 DEBUG : BROWSER_OUTPUT: 09:10:14 INFO - 2015-12-02 09:10:14,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:15 INFO - 2015-12-02 09:10:15,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 300756992 09:10:15 INFO - 2015-12-02 09:10:15,478 DEBUG : BROWSER_OUTPUT: 09:10:17 INFO - 2015-12-02 09:10:17,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:18 INFO - 2015-12-02 09:10:18,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 306692096 09:10:18 INFO - 2015-12-02 09:10:18,319 DEBUG : BROWSER_OUTPUT: 09:10:21 INFO - 2015-12-02 09:10:21,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:21 INFO - 2015-12-02 09:10:21,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 308404224 09:10:21 INFO - 2015-12-02 09:10:21,736 DEBUG : BROWSER_OUTPUT: 09:10:24 INFO - 2015-12-02 09:10:24,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:25 INFO - 2015-12-02 09:10:25,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 307560448 09:10:25 INFO - 2015-12-02 09:10:25,139 DEBUG : BROWSER_OUTPUT: 09:10:26 INFO - 2015-12-02 09:10:26,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 09:10:27 INFO - 2015-12-02 09:10:27,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 365862912 09:10:27 INFO - 2015-12-02 09:10:27,254 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;113;115;124;128;127;110;120;121;125 09:10:27 INFO - 2015-12-02 09:10:27,255 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;167;149;187;178;144;195;155;184;173;145 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;188;188;188;186;188;185;180;186;188 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;87;92;139;80;83;82;81;139;78 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;112;157;102;104;104;146;102;103;148 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;136;136;135;135;142;140;129;142;141 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;146;145;141;146;146;146 09:10:27 INFO - 2015-12-02 09:10:27,256 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;119;119;124;121;118;118;114;117;118 09:10:27 INFO - 2015-12-02 09:10:27,257 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;68;70;71;74;72;73;82;67;68 09:10:27 INFO - 2015-12-02 09:10:27,257 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;72;72;76;75;76;76;77;74;73 09:10:27 INFO - 2015-12-02 09:10:27,257 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;95;97;97;94;98;96;96;98;101 09:10:27 INFO - 2015-12-02 09:10:27,257 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;148;139;141;139;139;149;135;148;141 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;170;169;159;167;162;171;171;168;168 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;74;78;75;80;81;80;79;81;80 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 09:10:27 INFO - 2015-12-02 09:10:27,258 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:10:27 INFO - 2015-12-02 09:10:27,259 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076227251__endTimestamp 09:10:27 INFO - 2015-12-02 09:10:27,259 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,259 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:10:27 INFO - 2015-12-02 09:10:27,259 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.10 Median:122.50 stddev:6.08 (5.0%) stddev-sans-first:6.40 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: Values: 118.0 113.0 115.0 124.0 128.0 127.0 110.0 120.0 121.0 125.0 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:167.70 Median:175.50 stddev:18.58 (10.6%) stddev-sans-first:19.70 09:10:27 INFO - 2015-12-02 09:10:27,260 DEBUG : BROWSER_OUTPUT: Values: 167.0 149.0 187.0 178.0 144.0 195.0 155.0 184.0 173.0 145.0 09:10:27 INFO - 2015-12-02 09:10:27,261 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,261 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.70 Median:188.00 stddev:3.20 (1.7%) stddev-sans-first:2.65 09:10:27 INFO - 2015-12-02 09:10:27,261 DEBUG : BROWSER_OUTPUT: Values: 180.0 188.0 188.0 188.0 186.0 188.0 185.0 180.0 186.0 188.0 09:10:27 INFO - 2015-12-02 09:10:27,261 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,261 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.70 Median:82.50 stddev:23.68 (28.7%) stddev-sans-first:24.91 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 92.0 139.0 80.0 83.0 82.0 81.0 139.0 78.0 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.80 Median:111.00 stddev:22.18 (20.0%) stddev-sans-first:23.30 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 157.0 102.0 104.0 104.0 146.0 102.0 103.0 148.0 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,262 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.20 Median:138.00 stddev:4.08 (3.0%) stddev-sans-first:4.30 09:10:27 INFO - 2015-12-02 09:10:27,264 DEBUG : BROWSER_OUTPUT: Values: 136.0 136.0 136.0 135.0 135.0 142.0 140.0 129.0 142.0 141.0 09:10:27 INFO - 2015-12-02 09:10:27,264 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,264 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:1.71 (1.2%) stddev-sans-first:1.74 09:10:27 INFO - 2015-12-02 09:10:27,264 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 146.0 145.0 141.0 146.0 146.0 146.0 09:10:27 INFO - 2015-12-02 09:10:27,264 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.60 Median:118.50 stddev:2.59 (2.2%) stddev-sans-first:2.74 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 119.0 124.0 121.0 118.0 118.0 114.0 117.0 118.0 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.50 stddev:5.27 (7.4%) stddev-sans-first:4.56 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: Values: 62.0 68.0 70.0 71.0 74.0 72.0 73.0 82.0 67.0 68.0 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:75.50 stddev:2.49 (3.3%) stddev-sans-first:1.88 09:10:27 INFO - 2015-12-02 09:10:27,265 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 72.0 76.0 75.0 76.0 76.0 77.0 74.0 73.0 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:96.50 stddev:2.90 (3.0%) stddev-sans-first:2.03 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: Values: 90.0 95.0 97.0 97.0 94.0 98.0 96.0 96.0 98.0 101.0 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:144.00 stddev:4.95 (3.4%) stddev-sans-first:4.99 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 139.0 141.0 139.0 139.0 149.0 135.0 148.0 141.0 09:10:27 INFO - 2015-12-02 09:10:27,266 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.50 stddev:4.22 (2.5%) stddev-sans-first:4.12 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: Values: 162.0 170.0 169.0 159.0 167.0 162.0 171.0 171.0 168.0 168.0 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:80.00 stddev:2.82 (3.5%) stddev-sans-first:2.55 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 78.0 75.0 80.0 81.0 80.0 79.0 81.0 80.0 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:10:27 INFO - 2015-12-02 09:10:27,268 DEBUG : BROWSER_OUTPUT: 09:10:27 INFO - 2015-12-02 09:10:27,924 INFO : Browser exited with error code: 0 09:10:27 INFO - 2015-12-02 09:10:27,982 INFO : Completed test kraken (00:01:00) 09:10:27 INFO - 2015-12-02 09:10:27,982 INFO : Starting test v8_7 09:10:27 INFO - 2015-12-02 09:10:27,982 DEBUG : operating with platform_type : mac_ 09:10:27 INFO - 2015-12-02 09:10:27,983 INFO : Initialising browser for v8_7 test... 09:10:27 INFO - 2015-12-02 09:10:27,998 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmp3QY75d/profile http://localhost:49288/getInfo.html 09:10:30 INFO - 2015-12-02 09:10:30,350 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:10:30 INFO - 2015-12-02 09:10:30,350 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:10:30 INFO - 2015-12-02 09:10:30,350 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:10:30 INFO - 2015-12-02 09:10:30,350 DEBUG : BROWSER_OUTPUT: __metrics 09:10:30 INFO - 2015-12-02 09:10:30,366 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:31 INFO - 2015-12-02 09:10:31,016 INFO : Browser initialized. 09:10:31 INFO - 2015-12-02 09:10:31,016 INFO : Running cycle 1/1 for v8_7 test... 09:10:31 INFO - 2015-12-02 09:10:31,017 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmp3QY75d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:10:42 INFO - 2015-12-02 09:10:42,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 197832704 09:10:42 INFO - 2015-12-02 09:10:42,961 DEBUG : BROWSER_OUTPUT: 09:11:05 INFO - 2015-12-02 09:11:05,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49288/tests/v8_7/run.html (next: http://localhost:49288/tests/v8_7/run.html) 09:11:06 INFO - 2015-12-02 09:11:06,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 513400832 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: |0;Richards;186.84603886397608 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;209.95171110644552 09:11:06 INFO - 2015-12-02 09:11:06,038 DEBUG : BROWSER_OUTPUT: |2;Encrypt;364.8303538854433 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6493.506493506494 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1270.6480304955528 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |5;Earley;801.2820512820513 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |6;Boyer;14253.521126760563 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |7;RegExp;33583.333333333336 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |8;Splay;662.6984126984127 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6555.555555555556 09:11:06 INFO - 2015-12-02 09:11:06,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076266031__endTimestamp 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.85 Median:186.85 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: Values: 186.8 09:11:06 INFO - 2015-12-02 09:11:06,040 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:209.95 Median:209.95 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: Values: 210.0 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:364.83 Median:364.83 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: Values: 364.8 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,041 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6493.51 Median:6493.51 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: Values: 6493.5 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1270.65 Median:1270.65 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: Values: 1270.6 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: Values: 801.3 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14253.52 Median:14253.52 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,042 DEBUG : BROWSER_OUTPUT: Values: 14253.5 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33583.33 Median:33583.33 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: Values: 33583.3 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:662.70 Median:662.70 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: Values: 662.7 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,043 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6555.56 Median:6555.56 stddev:0.00 (0.0%) 09:11:06 INFO - 2015-12-02 09:11:06,044 DEBUG : BROWSER_OUTPUT: Values: 6555.6 09:11:06 INFO - 2015-12-02 09:11:06,044 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:11:06 INFO - 2015-12-02 09:11:06,044 DEBUG : BROWSER_OUTPUT: 09:11:06 INFO - 2015-12-02 09:11:06,682 INFO : Browser exited with error code: 0 09:11:06 INFO - 2015-12-02 09:11:06,706 INFO : Completed test v8_7 (00:00:38) 09:11:06 INFO - 2015-12-02 09:11:06,834 INFO : Completed test suite (00:20:14) 09:11:06 INFO - 2015-12-02 09:11:06,834 DEBUG : Working with test: dromaeo_css 09:11:06 INFO - 2015-12-02 09:11:06,834 DEBUG : Generating results file: dromaeo_css 09:11:06 INFO - 2015-12-02 09:11:06,835 DEBUG : Working with test: kraken 09:11:06 INFO - 2015-12-02 09:11:06,835 DEBUG : Generating results file: kraken 09:11:06 INFO - 2015-12-02 09:11:06,835 INFO : javascript benchmark 09:11:06 INFO - 2015-12-02 09:11:06,835 DEBUG : Working with test: v8_7 09:11:06 INFO - 2015-12-02 09:11:06,835 DEBUG : Generating results file: v8_7 09:11:06 INFO - 2015-12-02 09:11:06,836 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:11:06 INFO - 2015-12-02 09:11:06,886 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:11:06 INFO - 2015-12-02 09:11:06,886 DEBUG : process_Request line: dromaeo_css 5862.18 graph.html#tests=[[72,52,55]] 09:11:06 INFO - 2015-12-02 09:11:06,887 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:11:07 INFO - 2015-12-02 09:11:07,006 DEBUG : process_Request line: kraken 1716.80 graph.html#tests=[[232,52,55]] 09:11:07 INFO - 2015-12-02 09:11:07,007 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:11:07 INFO - 2015-12-02 09:11:07,038 DEBUG : process_Request line: v8_7 17804.79 graph.html#tests=[[230,52,55]] 09:11:07 INFO - 2015-12-02 09:11:07,039 INFO : javascript benchmark 09:11:07 INFO - 2015-12-02 09:11:07,041 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [283.9630847989761, 294.79511739341154, 310.5931230088584, 310.65982748889957, 317.65534395181226, 13325.333733313344, 13567.660808479768, 15393.846061539381, 15455.22723863808, 15558.922205388986, 13768.24274664893, 15925.601859953507, 15967.0, 16184.75722864155, 16371.91814040931, 4522.276435770269, 4586.97706511467, 4708.317293992369, 4726.858194254178, 4782.306565547993, 3567.1795487038, 3645.270945810835, 3678.2275722098393, 4554.134714404253, 4609.7234165949985, 4916.3608730864935, 4968.378952630921, 5055.671381360218, 5091.847244582668, 5143.562797162227, 4980.800767969277, 5059.848204553851, 5084.415292241384, 5147.6654017488745, 5186.766595503212, 4522.8643140705835, 4524.796384162721, 4530.07133537624, 4531.048479819242, 4557.658175636808, 11256.831147532794, 19317.323893663794, 19464.0, 19519.0, 19699.310524131586, 1548.4128768012877, 1690.3745614122731, 1699.337258469198, 1751.9778382290574, 1778.386456672446, 8427.073021967579, 8527.701530446404, 8731.476111433334, 8755.518446485441, 8774.254188393994, 1295.5012320256674, 1317.9538716144984, 1382.2259534660523, 1401.4254155796177, 1437.7987081808556, 51291.743541282056, 53561.732191339186, 54058.0, 54384.18423723687, 55034.72482637601, 5807.738651760681, 5811.099279611667, 5892.705364731746, 5936.37668044849, 6076.75692972285, 6793.116894803644, 6889.931100689029, 6891.793246202622, 6909.792706218822, 6926.030355750199, 4889.43538067822, 4976.377952755905, 4993.875153121128, 5094.439611642716, 5096.439391666913, 5378.166384210375, 5385.7307134643115, 5388.865278368072, 5433.809816656398, 5437.755301011464, 2658.189252278035, 2667.026535314596, 2675.478281735082, 2677.7857771378244, 2703.378223008719, 926.2451102351562, 935.6818681648273, 975.9947254328054, 994.5822754443151, 1000.099910080933, 388.6366247558542, 395.5470985721333, 412.72759978414103, 421.02952694040533, 427.6087380047284, 10337.22470814692, 10515.263931524873, 10619.787604247871, 10632.840507392395, 10855.131589472823, 364.6845478660939, 392.22731219497547, 395.67752281890165, 405.15120821878116, 408.2202992284781, 5386.91919621206, 5622.437756224426, 5784.59507834456, 5797.826065218051, 5833.7083145842535, 476190.0, 476364.0, 480412.0, 487342.0, 509568.0, 62853.37146628475, 65015.67492162509, 65645.34354656392, 66115.66942165258, 66629.0, 403.0, 411.5164681499226, 414.64340667026335, 415.70069549924006, 417.2635298697801, 9704.223662107155, 9796.65711700087, 9882.209423245979, 9918.156956658764, 10023.398596084258, 31708.0, 32106.357872841945, 32334.19164520906, 32401.837990809894, 32870.506942396365, 42622.0, 42819.57180428156, 43482.78258608687, 43513.0, 44052.11895762003, 5134.204198349262, 5211.895762084813, 5229.6339256251695, 5262.947370526399, 5317.548008419328, 9665.565049572926, 9710.805783884141, 9793.755156121155, 9806.26453016041, 9867.851982220129, 7688.538687678757, 7866.016747906512, 7891.84216315682, 8153.592320383838, 8652.740417787476, 7933.563653999086, 8135.877961830695, 8330.0, 8812.515311657664, 8915.153060459246, 8497.787555311166, 8976.685815996409, 9244.722658320261, 9249.676261330822, 9262.0, 5534.1145416733125, 5594.328680558359, 5660.20757093999, 5701.4298570142655, 5762.654240745569, 7643.656035478306, 9003.488639430758, 9073.77315567116, 9157.49633770149, 9197.172254497127], "dojo.html": [2813.1982385020265, 2867.268846444156, 2875.5255382861815, 2926.6634337051237, 2927.2974486123326, 4801.6398770092255, 4861.7812198451065, 4864.805407783689, 4896.632752543555, 4909.729964851932, 4722.38608980832, 4822.686525375857, 4903.289023091649, 4905.2396878483805, 4910.926336104962, 4327.372530983005, 4437.4896886858105, 4442.289233722605, 4488.910221795562, 4500.639948804088, 4497.685162038659, 4509.77451127444, 4510.751908645039, 4531.184386810372, 4563.406757121586, 4393.780310984438, 4495.1459222747735, 4499.595036446719, 4521.050579378334, 4530.864074077766, 4248.766317852533, 4386.385905973167, 4398.736075835428, 4431.202383570956, 4440.800163992628, 4406.867793966187, 4448.8442904498515, 4475.910481790378, 4479.888002799924, 4542.409486766732, 4583.060472603109, 4656.95343046572, 4720.527947205286, 4723.244280915037, 4802.084317400987, 5129.538341549279, 5203.297554830087, 5232.450592687751, 5238.554722848562, 5243.737813109367, 5231.215317702337, 5263.236830659571, 5269.0, 5277.788888444457, 5278.2082687596785, 4680.321353403806, 4720.362751028636, 4779.808807647724, 4793.49668284832, 4926.45808961014, 5279.788808447619, 5285.233641122016, 5293.179557168645, 5330.866728331745, 5356.0626890294825, 4934.8766280843265, 5000.374953130859, 5040.218766091261, 5043.495650435, 5059.165237735806, 4966.528179822911, 5066.16408292635, 5074.340335756402, 5101.2603172539775, 5181.740912954413, 5032.3206367139965, 5048.116579598555, 5063.87340316495, 5066.290719299301, 5155.587552995751, 5007.47421520735, 5058.190689489664, 5099.286099946011, 5102.285680004802, 5120.692758434506, 3715.9442608360896, 3867.5165604299464, 3950.150717595731, 3992.0, 4018.678505719535, 3602.2615363850346, 3604.3512167810045, 3627.3289441453417, 3627.4921510988484, 3687.9631203688155, 4785.784639691222, 4834.371531700926, 4856.247281671346, 4860.635452341018, 4867.683600565952, 4925.21196608541, 5025.623078269145, 5050.141475949097, 5080.822171223989, 5237.790488380422, 4768.332433459318, 4770.618350532019, 4777.331173635694, 4801.351817504662, 4823.348847905488, 4408.493023302297, 4493.146302202636, 4494.752788596658, 4497.965467942392, 4535.342375355555, 4968.602511799119, 5074.898502030012, 5096.566791822588, 5207.062728708793, 5239.161734122522, 5273.736313184402, 5274.393444753749, 5284.577233821208, 5287.365516138088, 5307.0, 5277.551408130352, 5279.47205279469, 5318.042752304622, 5342.065138600807, 5394.083005889087, 4954.925676114789, 4977.552020318189, 5018.4981501849525, 5099.209622508517, 5234.2672025915645, 5243.8164664236565, 5245.659032162897, 5278.023565640369, 5301.1783173608155, 5310.256564081109, 5060.0, 5079.44126146131, 5102.948970510248, 5142.851436503338, 5190.455002224712, 4704.200285951465, 5005.524475174852, 5091.745412729423, 5097.286379906742, 5137.1010073237785, 4987.700737955734, 4988.775505102351, 4992.650514463952, 5002.849914502571, 5029.0, 5115.2582875483595, 5143.665661731976, 5205.245239440335, 5206.687598744087, 5210.0, 4722.598579120813, 4769.594584460221, 4889.9022019560125, 4938.506149385176, 4948.62885283598], "mootools.html": [1143.605456117639, 1523.9771403428947, 1591.108978971776, 1599.8800089993247, 1610.2914717524295, 5755.136729490573, 6147.13940048393, 6295.937040629592, 6423.775167869126, 6493.220813502375, 6167.691615419233, 6375.776847810327, 6387.936120638792, 6391.744330226797, 6435.452986496141, 1867.5237814357354, 1868.4955062133215, 1874.1940965384879, 1898.9335373261938, 1904.6857268550673, 1919.7137917595244, 1920.1263425141526, 1946.9610607787836, 1953.8534609904243, 1968.3406058970263, 1870.3827736846877, 1877.8873267603988, 1880.2385034061226, 1888.7166924961298, 1892.0350621183159, 1807.4848668129587, 1810.1039985207276, 1817.5365281853176, 1823.4529641107747, 1830.7916774928617, 1882.2471011595471, 1888.8205620466172, 1900.4583693647244, 1905.8761180523222, 1919.587288732915, 5817.476427121537, 6386.0, 6437.678116094176, 6439.098526206335, 6440.033994900802, 3568.2506673598577, 3939.468171796799, 4035.9192816143805, 4067.2272268268935, 4130.0500884796365, 2377.976220237793, 2420.552197843387, 2422.2854257993936, 2429.0526694589125, 2432.586460301753, 744.2743325257884, 753.6420200404818, 770.3952397368096, 780.8906753054576, 790.6679194738224, 8395.580220988988, 8397.034341050796, 8420.157984201593, 8464.619092140807, 8518.446300990478, 3526.559180102487, 3569.696575791035, 3654.3056819204267, 3690.151265209017, 3698.0754811297174, 7437.776866694008, 7458.105027396748, 7496.100467943882, 7551.244875512405, 7573.242675732493, 4078.8164532596106, 4098.979505102515, 4121.608447197512, 4154.148399578079, 4167.312393455046, 3747.737658363943, 3749.8125093745202, 3767.4913886625504, 3774.207416442523, 3800.733948623625, 2997.565353023843, 3017.0, 3036.878524858981, 3094.535819627074, 3123.515855042472, 952.3619175152526, 954.4225743425128, 961.7884065505577, 975.7999610079917, 986.5807032011367, 890.8841850559386, 922.0733163171104, 1140.885911408869, 1186.3771519951922, 1188.7979043562616, 6072.119542666289, 6096.207493025879, 6133.96933015341, 6143.723532440961, 6167.0, 989.0, 995.0845222395413, 1014.1481155829139, 1029.5161274201114, 1034.1726618705006, 5036.597072234213, 5079.187330027178, 5084.542391184811, 5106.795728170906, 5114.360704911886, 7158.319959603829, 7297.927020729831, 7510.061242344707, 7565.508241964255, 7603.885941710879, 7526.435517336222, 7566.956921631128, 7586.658600362997, 7648.0, 7727.536347819037, 6091.360407157274, 6117.938820611826, 6177.104319873683, 6223.222097237845, 6292.622442653547, 6150.261968563801, 6156.846078848064, 6159.784407545714, 6161.137440758208, 6214.0, 6915.0, 6970.616616086164, 6975.476839236976, 7021.227664956748, 7051.259617740268, 6961.303869612998, 7097.467689923174, 7197.496175267681, 7201.4238860889955, 7213.134423869169, 5561.0, 5601.971990140023, 5633.887322253614, 5635.0, 5652.0, 6244.125822384961, 6281.811545653638, 6298.338674439118, 6300.086487459201, 6415.9358406417205, 5877.853053673693, 5890.528757699288, 5930.406959304208, 5959.553033522589, 5963.13534537481, 5708.400617935057, 5784.566157538286, 5795.710214489343, 5825.3883342248455, 5860.355360910382, 5781.277340332458, 5829.795957141479, 5928.288605367384, 5935.792247271324, 5938.910916336172, 5017.949820501748, 5143.871403214949, 5145.948540514697, 5157.793688252578, 5181.119209734279, 5182.196759502283, 5254.106801843619, 5285.101532739367, 5290.761915713879, 5334.813281535127], "ext.html": [502.78882869194933, 506.8682142642914, 510.0513045734932, 515.296620113545, 541.90245755764, 28183.0, 29604.85197574012, 35234.47148292778, 36108.0, 36142.638573614255, 38072.80963595185, 38665.806670966675, 38675.22649547007, 38708.80645596768, 39370.803145984304, 7647.0, 8326.292265157468, 8331.416800823945, 8376.49741015538, 8452.28155606774, 7634.083909930816, 9820.36167649104, 10008.049235322633, 10022.398656080659, 10082.74793130174, 9009.864852027225, 9792.363496372749, 9850.310478266489, 9853.162481189107, 9866.260030497706, 7720.305172534443, 7877.36981041521, 9685.564149613285, 9810.65662701802, 9883.406995580252, 9663.082007209305, 9700.466474343908, 9809.21526277896, 9820.508974551316, 9952.402855828674, 35288.64711352905, 35355.82322088399, 35535.28929421423, 35725.46411803825, 35878.64121358805, 2463.1132792194794, 2533.2526904563015, 2569.1008147148536, 2738.9178324650093, 2919.5182794838825, 24648.753512464824, 24842.130525431523, 25013.62479562808, 25036.624450633255, 25278.115265965786, 2047.5495391013953, 2095.3399679101035, 2131.0, 2136.2416342198453, 2145.10977944153, 236917.0, 237302.0, 237762.0, 239869.80065099738, 240523.0, 53264.46735532595, 53854.0, 54062.45937540574, 54223.72888135534, 54632.0, 49175.508244917095, 51267.743661281456, 61158.0, 63719.36280637227, 64121.679391602745, 15318.463853765064, 15354.769678454832, 15369.001014933994, 15398.46105386306, 15416.691666166615, 11505.079593632488, 11508.769824603462, 11509.366984815748, 11681.941590292165, 11694.181407301578, 17440.5639859002, 17675.0, 17787.73318400225, 17801.7329740054, 17865.642687146184, 7548.849023019508, 7788.805279868048, 7827.45207835446, 7956.443048986631, 7969.402294827911, 863.48622569571, 899.9955000224957, 973.7808992976666, 1009.5053423822275, 1037.056278786316, 25222.49555008926, 25650.102246421287, 25888.482230355665, 25996.22011339663, 26034.479310413684, 887.272436601993, 893.2675206330877, 982.3761911186448, 991.2565575818137, 994.8656931314325, 12153.574624888086, 12673.17624354414, 12699.428525716365, 12725.045621578418, 12886.09797314179, 293206.0, 300809.0, 303347.0, 303844.0, 305852.0, 42125.0, 43160.78419607882, 47692.52307476881, 49447.0, 50106.49893501091, 1222.437678667805, 1229.7540491901834, 1242.1305086439347, 1267.9175853569488, 1298.7532368849888, 21059.684104738746, 23078.884605576866, 23808.0, 24617.261482155565, 24619.507609847344, 39868.2026359477, 40332.59667403289, 40336.79831600823, 40783.592164079164, 40996.59003410047, 226996.0, 228202.0, 232537.0, 234272.0, 236874.0, 26488.8675556621, 26528.0, 27062.594061089494, 27079.458410831277, 27133.86433067822, 36501.81749091238, 36569.63430365769, 36919.0, 37528.437073443376, 37905.62094379021, 30513.38973220479, 30982.380352393277, 31067.68932310648, 31112.844435777675, 31243.0, 30285.394292114474, 30517.694823051486, 30665.846670767394, 30766.384672306875, 30789.0, 32207.838960805046, 32424.675753243107, 32622.83688581542, 32788.344233115684, 32842.343153136324, 24093.879530602935, 24695.0, 26694.733052670003, 28841.85579072175, 29789.10632681023, 20698.793012069687, 21042.3682862162, 22215.888920555295, 22515.0, 22813.885930570243], "prototype.html": [282.4872855766783, 294.8555207948106, 297.5001996645635, 298.3495978766289, 299.85457053329145, 5200.817971371002, 5294.52349288564, 5375.48932851379, 5387.0841956867325, 5451.3458384993855, 5345.305110335661, 5354.598405119612, 5374.865628359293, 5379.946200537994, 5381.0852155133625, 4108.650764684998, 4139.648129908961, 4146.336586146217, 4158.2307273154565, 4206.116715489736, 4138.958610413887, 4146.688998325122, 4160.375943608453, 4175.519815221242, 4205.03284244624, 3907.374820028796, 4010.4786377770993, 4110.403991421242, 4125.587441255881, 4129.463169787939, 3992.7005474589378, 4031.1937612477623, 4035.8385664573384, 4038.414429907676, 4074.286999775057, 3478.4608385700258, 3480.564929383827, 3494.2138018945534, 3496.4930085137767, 3499.5975462821593, 5094.745262736848, 5108.386993560759, 5137.768800403954, 5167.9224811627855, 5219.973900130475, 4492.797824097924, 4568.086382723469, 4612.423447069116, 4633.791479383436, 4642.373279607244, 5455.781768729246, 5582.692951887645, 5638.943610563882, 5659.207710920475, 5675.404082571312, 3801.6388443097862, 3809.276237514863, 3821.14024344523, 3837.9040523986846, 3847.9230415391535, 5585.329760428734, 5679.744411501492, 5690.260266165414, 5754.510866576346, 5958.5828991970575, 3777.187904600469, 3814.6948244140403, 3836.462895194675, 3874.49631547897, 3879.7866117363815, 3894.8636797711943, 3925.2738243425056, 3929.7445666031617, 3946.3685810270217, 3954.62431069048, 4344.239758042393, 4452.532484089124, 4498.6626003049905, 4547.249703798902, 4552.430946131733, 5519.668819870741, 5540.667559946416, 5547.528460080938, 5587.245721827582, 5653.971730141323, 1386.6117487103627, 1403.3895255563862, 1408.2747385096684, 1414.0101928649985, 1418.099506813181, 857.7898414888392, 881.5592203898051, 883.0992387764444, 885.9911400886037, 916.9449833010041, 5275.63070585063, 5312.335958005249, 5334.413214546396, 5366.677999319975, 5385.973070134624, 5772.7113644317615, 5773.566982476331, 5810.912836307459, 5822.214001109796, 5862.853428664317, 5324.946750532445, 5351.625386223005, 5364.839054828283, 5380.542653874386, 5382.596305277119, 3114.5328200770064, 3191.824449655291, 3227.9193020174685, 3235.902922912316, 3283.0, 5905.173275741399, 5905.734241959036, 5905.852353691193, 5942.10868369748, 5963.910541341883, 5953.79161729346, 5974.701264936736, 5990.5507086968655, 5994.880102397928, 6047.123167140828, 5823.039198532364, 5842.678652674143, 5881.382454842265, 5902.822915312633, 5932.436418540232, 5710.914336284876, 5779.884402311846, 5789.507891829242, 5814.883702326015, 5858.794942177004, 5648.265725455664, 5675.120356344773, 5675.432456754292, 5685.630434021941, 5723.055695810144, 5834.94165058344, 5888.705564721661, 5889.204957330877, 5921.7631294747725, 5942.970285148546, 3667.449882517537, 3822.7515211511163, 3891.3579259421876, 3897.8635747748694, 3898.9220215596097, 5550.8057217997175, 5670.376258611467, 5772.9711351442975, 5802.593818432669, 5807.448292412214, 5522.6134170607675, 5555.638883472561, 5607.046802043581, 5610.9158362623775, 5622.381538030895, 5603.159526071122, 5612.354579223442, 5633.63381380209, 5637.718114094197, 5692.516136128475, 5144.382674078985, 5251.422343542284, 5478.479544443271, 5487.807926722546, 5495.368032676293, 5550.7779688812, 5567.0, 5640.294963129609, 5689.971550142222, 5704.771809127588, 5518.2826232591115, 5560.165975103767, 5562.193481945176, 5579.69311687861, 5629.408912064175], "yui.html": [603.6800495737259, 668.1114118222764, 670.3129292475211, 674.4402146218639, 677.9966100169498, 10949.233553651247, 11156.665300040991, 11245.044171245434, 11249.437528123592, 11574.016208622277, 11240.0, 11624.535018599267, 11767.823482647767, 11787.764244715101, 11833.29000259985, 658.0951192110848, 664.7307840324652, 792.0614072324299, 811.7118422959853, 812.1188510466122, 802.4182467710892, 815.6207363575936, 820.0897004325194, 821.8972628421448, 823.555280148722, 839.0770152831867, 850.9319254459659, 855.6064210463195, 855.7218903856271, 857.1257317536141, 671.2716702377926, 681.8363592737708, 832.6877420967137, 840.4873027453249, 850.8596081646521, 622.6233128957007, 630.4704048599153, 633.5311869216793, 636.4017823246134, 640.9903851442232, 11232.887671123266, 11881.34652594107, 12055.57805476804, 12059.276443413422, 12200.0, 10253.948730256376, 10315.1747860171, 10359.482025898751, 10554.313969592029, 11166.832497512463, 8028.638711258008, 8318.168183181693, 8409.663613455454, 8424.620892059873, 8461.83076338476, 2974.7917645764805, 3024.8185108893317, 3046.299351149226, 3074.8001379910233, 3104.9068527944196, 43466.34800477995, 43781.56218437807, 43806.34290485645, 44005.77997109994, 44083.55916440827, 7781.182975787574, 7937.603119843985, 7962.800929976681, 8008.039035315799, 8104.918950810416, 17551.473455796346, 17567.912160439373, 17574.38489652856, 17604.647907041788, 17791.73312400315, 5137.922931156036, 5225.5819534437915, 5308.309919710413, 5324.3078399808555, 5415.8104466344275, 3326.6507016763376, 3409.113630456099, 3409.5567576214935, 3439.810810405452, 3493.2664140530774, 2385.976140238575, 2412.662227288181, 2413.975860241375, 2417.758224177568, 2433.683621129277, 348.86045581767496, 351.8698081709733, 351.91905861651964, 356.13814568743703, 361.3369467028033, 468.39343050749363, 469.2351467108591, 475.5767367043334, 484.9960581596062, 510.6399988008519, 6241.687915604201, 6320.8419789504715, 6324.051392291101, 6531.934680653228, 6556.213254409406, 485.09771824406573, 491.74675042353215, 505.31782094172576, 512.845997117729, 513.1584201908872, 2898.739113479755, 3033.5904652872023, 3060.9540856887165, 3067.92330191747, 3170.651228364878, 50627.0, 54002.18996715052, 54601.45398545964, 54914.17628735572, 54990.0, 47142.5285747145, 47247.0, 47516.0, 47841.5215847844, 47846.0, 40569.0, 41002.1799564007, 41595.37606935899, 42751.572484275384, 42920.356194657106, 6847.554908930903, 7037.296270372922, 7103.289671032855, 7154.892676609751, 7370.852582948418, 31997.36005279928, 32775.0, 32970.340593188484, 33092.1726956828, 33411.0, 39210.60789392069, 39336.803315983234, 40392.0, 41204.58795412008, 42104.0, 6377.808665740035, 6578.703958321983, 6724.4620430364475, 6987.371136597731, 7016.894746578703, 9828.746055999978, 9878.802423951336, 9918.504074796087, 9961.50192490387, 10136.087752102347, 9039.322050846082, 9239.214666753402, 9369.625214991323, 9461.195798357217, 9516.476593787409, 9660.32377733552, 9672.95163524206, 9675.9032409675, 9728.562214700214, 9792.755181120529, 8901.510416926872, 9146.588403521724, 9210.585523651318, 9236.953815230881, 9298.070192980647, 7914.44598878073, 8387.664493420194, 8409.453385529921, 8419.410641255054, 8456.577171141542, 7736.149023607286, 8122.0, 8175.305099066408, 8352.540610266493, 8398.664053438039]}, "summary": {"suite": 5862.182770942502, "subtests": {"jquery.html": {"filtered": 6133.613373675868, "value": 6133.613373675868}, "dojo.html": {"filtered": 4765.095414334221, "value": 4765.095414334221}, "mootools.html": {"filtered": 3753.3476035153612, "value": 3753.3476035153612}, "ext.html": {"filtered": 16593.658896921148, "value": 16593.658896921148}, "prototype.html": {"filtered": 4204.985981832718, "value": 4204.985981832718}, "yui.html": {"filtered": 5301.492154585573, "value": 5301.492154585573}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1449075051, "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": "44.0a2", "id": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 188.0, 188.0, 188.0, 186.0, 188.0, 185.0, 180.0, 186.0, 188.0], "ai-astar": [118.0, 113.0, 115.0, 124.0, 128.0, 127.0, 110.0, 120.0, 121.0, 125.0], "imaging-gaussian-blur": [136.0, 136.0, 136.0, 135.0, 135.0, 142.0, 140.0, 129.0, 142.0, 141.0], "audio-beat-detection": [167.0, 149.0, 187.0, 178.0, 144.0, 195.0, 155.0, 184.0, 173.0, 145.0], "json-stringify-tinderbox": [69.0, 72.0, 72.0, 76.0, 75.0, 76.0, 76.0, 77.0, 74.0, 73.0], "stanford-crypto-pbkdf2": [162.0, 170.0, 169.0, 159.0, 167.0, 162.0, 171.0, 171.0, 168.0, 168.0], "json-parse-financial": [62.0, 68.0, 70.0, 71.0, 74.0, 72.0, 73.0, 82.0, 67.0, 68.0], "stanford-crypto-sha256-iterative": [74.0, 74.0, 78.0, 75.0, 80.0, 81.0, 80.0, 79.0, 81.0, 80.0], "audio-fft": [86.0, 87.0, 92.0, 139.0, 80.0, 83.0, 82.0, 81.0, 139.0, 78.0], "imaging-darkroom": [147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 141.0, 146.0, 146.0, 146.0], "stanford-crypto-ccm": [147.0, 148.0, 139.0, 141.0, 139.0, 139.0, 149.0, 135.0, 148.0, 141.0], "audio-oscillator": [110.0, 112.0, 157.0, 102.0, 104.0, 104.0, 146.0, 102.0, 103.0, 148.0], "stanford-crypto-aes": [90.0, 95.0, 97.0, 97.0, 94.0, 98.0, 96.0, 96.0, 98.0, 101.0], "imaging-desaturate": [118.0, 119.0, 119.0, 124.0, 121.0, 118.0, 118.0, 114.0, 117.0, 118.0]}, "summary": {"suite": 1716.8, "subtests": {"audio-fft": {"filtered": 94.7, "value": 94.7}, "stanford-crypto-pbkdf2": {"filtered": 166.7, "value": 166.7}, "audio-beat-detection": {"filtered": 167.7, "value": 167.7}, "stanford-crypto-ccm": {"filtered": 142.6, "value": 142.6}, "imaging-darkroom": {"filtered": 145.6, "value": 145.6}, "json-parse-financial": {"filtered": 70.7, "value": 70.7}, "audio-oscillator": {"filtered": 118.8, "value": 118.8}, "ai-astar": {"filtered": 120.1, "value": 120.1}, "audio-dft": {"filtered": 185.7, "value": 185.7}, "stanford-crypto-sha256-iterative": {"filtered": 78.2, "value": 78.2}, "json-stringify-tinderbox": {"filtered": 74.0, "value": 74.0}, "imaging-gaussian-blur": {"filtered": 137.2, "value": 137.2}, "stanford-crypto-aes": {"filtered": 96.2, "value": 96.2}, "imaging-desaturate": {"filtered": 118.6, "value": 118.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1449075051, "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": "44.0a2", "id": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [209.95171110644552], "Encrypt": [364.8303538854433], "NavierStokes": [6555.555555555556], "Decrypt": [6493.506493506494], "Splay": [662.6984126984127], "Richards": [186.84603886397608], "RegExp": [33583.333333333336], "Earley": [801.2820512820513], "Boyer": [14253.521126760563], "RayTrace": [1270.6480304955528]}, "summary": {"suite": 17804.790565523985, "subtests": {"DeltaBlue": {"filtered": 314.920034, "value": 314.920034}, "Encrypt": {"filtered": 729.6021210000002, "value": 729.6021210000002}, "NavierStokes": {"filtered": 226.372881355932, "value": 226.372881355932}, "Decrypt": {"filtered": 40.991874, "value": 40.991874}, "Splay": {"filtered": 122.96845508982041, "value": 122.96845508982041}, "RegExp": {"filtered": 27.126104218362286, "value": 27.126104218362286}, "Richards": {"filtered": 188.93630400000006, "value": 188.93630400000006}, "Earley": {"filtered": 831.745824, "value": 831.745824}, "Boyer": {"filtered": 46.7577796442688, "value": 46.7577796442688}, "RayTrace": {"filtered": 582.3713429999998, "value": 582.3713429999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1449075051, "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": "44.0a2", "id": "20151202071122", "branch": "Mozilla-Aurora", "revision": "bd29d7c987b554842ccee62dad4dec506e98227e"}}] 09:11:07 INFO - RETURN: dromaeo_css: 5862.18 09:11:07 INFO - RETURN: kraken: 1716.80 09:11:07 INFO - RETURN: v8_7: 17804.79 09:11:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17804.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1716.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5862.18"}}} 09:11:07 INFO - Return code: 0 09:11:07 INFO - # TBPL SUCCESS # 09:11:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:07 INFO - 2015-12-02 09:11:07.165 screenresolution[1657:9935] starting screenresolution argv=screenresolution get 09:11:07 INFO - 2015-12-02 09:11:07.169 screenresolution[1657:9935] Display 0: 1600x1200x32@60 09:11:07 INFO - 2015-12-02 09:11:07.175 screenresolution[1658:9939] starting screenresolution argv=screenresolution list 09:11:07 INFO - Available Modes on Display 0 09:11:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:07 INFO - Intel HD Graphics 3000: 09:11:07 INFO - Chipset Model: Intel HD Graphics 3000 09:11:07 INFO - Type: GPU 09:11:07 INFO - Bus: Built-In 09:11:07 INFO - VRAM (Total): 512 MB 09:11:07 INFO - VRAM (Dynamic, Max): 10 09:11:07 INFO - Vendor: Intel (0x8086) 09:11:07 INFO - Device ID: 0x0116 09:11:07 INFO - Revision ID: 0x0009 09:11:07 INFO - Displays: 09:11:07 INFO - Display: 09:11:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:07 INFO - Display Serial Number: 1600x1200 60 09:11:07 INFO - Main Display: Yes 09:11:07 INFO - Mirror: Off 09:11:07 INFO - Online: Yes 09:11:07 INFO - Rotation: Supported 09:11:07 INFO - Return code: 0 09:11:07 INFO - Running post-action listener: _resource_record_post_action 09:11:07 INFO - Running post-run listener: _resource_record_post_run 09:11:08 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 38585344; Write bytes: 680571904; Read time: 4620; Write time: 52716 09:11:08 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 337355264; Write bytes: 333776896; Read time: 35465; Write time: 3895 09:11:08 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 36791296; Write bytes: 335698944; Read time: 4319; Write time: 48098 09:11:08 INFO - Running post-run listener: _upload_blobber_files 09:11:08 INFO - Blob upload gear active. 09:11:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:11:08 INFO - Copying logs to upload dir... 09:11:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.727002 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-12-02 09:11:08.596144) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:11:08.600036) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/r4GV-N4TR1-m49YgJKg9kA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:11:08.621488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:11:08.621822) ========= 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.IVnTccHjbj/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.0MXDNXL7QS/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.005342 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:11:08.671491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:11:08.671827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:11:08.672232) ========= ========= Total master_lag: 4.78 =========