builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0066 starttime: 1447582240.94 results: success (0) buildid: 20151115004211 builduid: a8f690e9885c465da818ce9b63b06ab5 revision: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:40.943520) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:40.943971) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:40.944277) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.007100 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:40.971774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:40.972065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.025199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.025517) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.006289 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.095571) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.095888) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.096243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.096531) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 02:10:41-- 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% 51.5M=0s 2015-11-15 02:10:41 (51.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.362370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.476663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.477017) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.022738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.528204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:41.528547) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6161cc379b78e4fef8195c3f62a1603acf7b59 --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 4b6161cc379b78e4fef8195c3f62a1603acf7b59 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 02:10:41,623 truncating revision to first 12 chars 2015-11-15 02:10:41,623 Setting DEBUG logging. 2015-11-15 02:10:41,623 attempt 1/10 2015-11-15 02:10:41,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b6161cc379b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 02:10:41,907 unpacking tar archive at: mozilla-aurora-4b6161cc379b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590443 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:42.151696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:42.152184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:42.281769) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:42.282019) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 02:10:42.282390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-15 02:10:42.282695) ========= /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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:10:42 INFO - MultiFileLogger online at 20151115 02:10:42 in /builds/slave/test 02:10:42 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 02:10:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:42 INFO - {'append_to_log': False, 02:10:42 INFO - 'base_work_dir': '/builds/slave/test', 02:10:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:10:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:42 INFO - 'branch': 'Mozilla-Aurora', 02:10:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:42 INFO - 'config_files': ('talos/mac_config.py',), 02:10:42 INFO - 'default_actions': ('clobber', 02:10:42 INFO - 'read-buildbot-config', 02:10:42 INFO - 'download-and-extract', 02:10:42 INFO - 'populate-webroot', 02:10:42 INFO - 'create-virtualenv', 02:10:42 INFO - 'install', 02:10:42 INFO - 'run-tests'), 02:10:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:42 INFO - 'download_minidump_stackwalk': True, 02:10:42 INFO - 'download_symbols': 'ondemand', 02:10:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:42 INFO - 'installer_path': 'installer.exe', 02:10:42 INFO - 'log_level': 'info', 02:10:42 INFO - 'log_name': 'talos', 02:10:42 INFO - 'log_to_console': True, 02:10:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:10:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:10:42 INFO - 'opt_config_files': (), 02:10:42 INFO - 'pip_index': False, 02:10:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:42 INFO - 'cmd': ('bash', 02:10:42 INFO - '-c', 02:10:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:42 INFO - 'enabled': True, 02:10:42 INFO - 'halt_on_failure': False, 02:10:42 INFO - 'name': 'check_screen_resolution'},), 02:10:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:42 INFO - 'cmd': ('bash', 02:10:42 INFO - '-c', 02:10:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:42 INFO - 'enabled': True, 02:10:42 INFO - 'halt_on_failure': False, 02:10:42 INFO - 'name': 'check_screen_resolution'},), 02:10:42 INFO - 'run_cmd_checks_enabled': True, 02:10:42 INFO - 'sps_profile': False, 02:10:42 INFO - 'sps_profile_interval': 0, 02:10:42 INFO - 'suite': 'dromaeojs', 02:10:42 INFO - 'system_bits': '64', 02:10:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:42 INFO - 'title': 't-yosemite-r5-0066', 02:10:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:42 INFO - 'use_talos_json': True, 02:10:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:42 INFO - 'work_dir': 'build'} 02:10:42 INFO - ##### 02:10:42 INFO - ##### Running clobber step. 02:10:42 INFO - ##### 02:10:42 INFO - Running pre-action listener: _resource_record_pre_action 02:10:42 INFO - Running main action method: clobber 02:10:42 INFO - rmtree: /builds/slave/test/build 02:10:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:45 INFO - Running post-action listener: _resource_record_post_action 02:10:45 INFO - ##### 02:10:45 INFO - ##### Running read-buildbot-config step. 02:10:45 INFO - ##### 02:10:45 INFO - Running pre-action listener: _resource_record_pre_action 02:10:45 INFO - Running main action method: read_buildbot_config 02:10:45 INFO - Using buildbot properties: 02:10:45 INFO - { 02:10:45 INFO - "properties": { 02:10:45 INFO - "buildnumber": 421, 02:10:45 INFO - "product": "firefox", 02:10:45 INFO - "script_repo_revision": "production", 02:10:45 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:10:45 INFO - "repository": "", 02:10:45 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:10:45 INFO - "buildid": "20151115004211", 02:10:45 INFO - "slavename": "t-yosemite-r5-0066", 02:10:45 INFO - "stage_platform": "macosx64", 02:10:45 INFO - "basedir": "/builds/slave/test", 02:10:45 INFO - "nightly_build": "True", 02:10:45 INFO - "project": "", 02:10:45 INFO - "platform": "yosemite", 02:10:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:10:45 INFO - "slavebuilddir": "test", 02:10:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:10:45 INFO - "branch": "mozilla-aurora", 02:10:45 INFO - "repo_path": "releases/mozilla-aurora", 02:10:45 INFO - "pgo_build": "False", 02:10:45 INFO - "builduid": "a8f690e9885c465da818ce9b63b06ab5", 02:10:45 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 02:10:45 INFO - }, 02:10:45 INFO - "sourcestamp": { 02:10:45 INFO - "repository": "", 02:10:45 INFO - "hasPatch": false, 02:10:45 INFO - "project": "", 02:10:45 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:10:45 INFO - "changes": [ 02:10:45 INFO - { 02:10:45 INFO - "category": null, 02:10:45 INFO - "files": [ 02:10:45 INFO - { 02:10:45 INFO - "url": null, 02:10:45 INFO - "name": "https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:10:45 INFO - } 02:10:45 INFO - ], 02:10:45 INFO - "repository": "", 02:10:45 INFO - "rev": "4b6161cc379b78e4fef8195c3f62a1603acf7b59", 02:10:45 INFO - "who": "sendchange", 02:10:45 INFO - "when": 1447582193, 02:10:45 INFO - "number": 6663271, 02:10:45 INFO - "comments": "", 02:10:45 INFO - "project": "", 02:10:45 INFO - "at": "Sun 15 Nov 2015 02:09:53", 02:10:45 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:10:45 INFO - "revlink": "", 02:10:45 INFO - "properties": [ 02:10:45 INFO - [ 02:10:45 INFO - "buildid", 02:10:45 INFO - "20151115004211", 02:10:45 INFO - "Change" 02:10:45 INFO - ], 02:10:45 INFO - [ 02:10:45 INFO - "builduid", 02:10:45 INFO - "a8f690e9885c465da818ce9b63b06ab5", 02:10:45 INFO - "Change" 02:10:45 INFO - ], 02:10:45 INFO - [ 02:10:45 INFO - "nightly_build", 02:10:45 INFO - "True", 02:10:45 INFO - "Change" 02:10:45 INFO - ], 02:10:45 INFO - [ 02:10:45 INFO - "pgo_build", 02:10:45 INFO - "False", 02:10:45 INFO - "Change" 02:10:45 INFO - ] 02:10:45 INFO - ], 02:10:45 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 02:10:45 INFO - } 02:10:45 INFO - ], 02:10:45 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 02:10:45 INFO - } 02:10:45 INFO - } 02:10:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:10:45 INFO - Running post-action listener: _resource_record_post_action 02:10:45 INFO - ##### 02:10:45 INFO - ##### Running download-and-extract step. 02:10:45 INFO - ##### 02:10:45 INFO - Running pre-action listener: _resource_record_pre_action 02:10:45 INFO - Running main action method: download_and_extract 02:10:45 INFO - mkdir: /builds/slave/test/build/tests 02:10:45 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')]} 02:10:45 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/test_packages.json 02:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/test_packages.json 02:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:10:45 INFO - Downloaded 1149 bytes. 02:10:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:10:45 INFO - Using the following test package requirements: 02:10:45 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:10:45 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:10:45 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'jsshell-mac.zip'], 02:10:45 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:10:45 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:10:45 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:10:45 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:10:45 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:10:45 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:10:45 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:10:45 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:10:45 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:10:45 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')]} 02:10:45 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:10:46 INFO - Downloaded 17447705 bytes. 02:10:46 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 02:10:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:10:52 INFO - Return code: 0 02:10:52 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 02:10: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')]} 02:10:52 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:10:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:10:56 INFO - Downloaded 17447705 bytes. 02:10:56 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 02:10:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:10:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:11:02 INFO - Return code: 0 02:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:02 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:11:03 INFO - Downloaded 11131307 bytes. 02:11:03 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 02:11:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:11:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:11:03 INFO - Return code: 0 02:11:03 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')]} 02:11:03 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:11:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:11:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:11:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:11:09 INFO - Downloaded 107791741 bytes. 02:11:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:11:09 INFO - mkdir: /builds/slave/test/properties 02:11:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:09 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:09 INFO - Contents: 02:11:09 INFO - build_url:https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:11:09 INFO - Running post-action listener: _resource_record_post_action 02:11:09 INFO - Running post-action listener: set_extra_try_arguments 02:11:09 INFO - ##### 02:11:09 INFO - ##### Running populate-webroot step. 02:11:09 INFO - ##### 02:11:09 INFO - Running pre-action listener: _resource_record_pre_action 02:11:09 INFO - Running main action method: populate_webroot 02:11:09 INFO - Guessing talos json url... 02:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:09 INFO - https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6DYzn2usQQOLo_vlHRfd4g/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 02:11:10 INFO - Downloaded 107 bytes. 02:11:10 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:11:10 INFO - Contents: 02:11:10 INFO - 20151115004211 02:11:10 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/4b6161cc379b78e4fef8195c3f62a1603acf7b59 02:11: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')]} 02:11:10 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json 02:11:10 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:11:10 INFO - Downloaded 4264 bytes. 02:11:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:11:10 INFO - '../fennec_ids.txt'], 02:11:10 INFO - 'tests': ['tcheck2']}, 02:11:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:10 INFO - '--tppagecycles', 02:11:10 INFO - '7'], 02:11:10 INFO - 'tests': ['tsvgm']}}, 02:11:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:11:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:11:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:11:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'tests': ['damp', 'tps']}, 02:11:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['damp', 'tps']}, 02:11:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:11:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:10 INFO - 'other': {'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'other_l64': {'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'other_nol64': {'tests': ['a11yr', 02:11:10 INFO - 'ts_paint', 02:11:10 INFO - 'tpaint', 02:11:10 INFO - 'sessionrestore', 02:11:10 INFO - 'sessionrestore_no_auto_restore']}, 02:11:10 INFO - 'svgr': {'tests': ['tsvgx', 02:11:10 INFO - 'tsvgr_opacity', 02:11:10 INFO - 'tart', 02:11:10 INFO - 'tscrollx', 02:11:10 INFO - 'cart']}, 02:11:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['tsvgx', 02:11:10 INFO - 'tsvgr_opacity', 02:11:10 INFO - 'tart', 02:11:10 INFO - 'tscrollx', 02:11:10 INFO - 'cart']}, 02:11:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'tests': ['tp5o']}, 02:11:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'talos_options': ['--e10s'], 02:11:10 INFO - 'tests': ['tp5o']}, 02:11:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'talos_options': ['--xperf_path', 02:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:10 INFO - 'tests': ['tp5n']}, 02:11:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:10 INFO - 'talos_options': ['--e10s', 02:11:10 INFO - '--xperf_path', 02:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:11:10 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:11:10 INFO - 'tests': ['tp5n']}}, 02:11:10 INFO - 'talos.zip': {'path': '', 02:11:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:10 INFO - Running post-action listener: _resource_record_post_action 02:11:10 INFO - ##### 02:11:10 INFO - ##### Running create-virtualenv step. 02:11:10 INFO - ##### 02:11:10 INFO - Running pre-action listener: _resource_record_pre_action 02:11:10 INFO - Running main action method: create_virtualenv 02:11:10 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:10 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 02:11:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:11 INFO - Using real prefix '/tools/python27' 02:11:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:15 INFO - Installing pip.................done. 02:11:16 INFO - Return code: 0 02:11:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11:16 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')]} 02:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:16 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')]} 02:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:16 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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:16 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 02:11:16 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 02:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:16 INFO - 'HOME': '/Users/cltbld', 02:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:16 INFO - 'LOGNAME': 'cltbld', 02:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:16 INFO - 'MOZ_NO_REMOTE': '1', 02:11:16 INFO - 'NO_EM_RESTART': '1', 02:11:16 INFO - 'PAGER': '/bin/cat', 02:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:16 INFO - 'PWD': '/builds/slave/test', 02:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:16 INFO - 'SHELL': '/bin/bash', 02:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:16 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:16 INFO - 'USER': 'cltbld', 02:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:16 INFO - 'XPC_FLAGS': '0x0', 02:11:16 INFO - 'XPC_SERVICE_NAME': '0', 02:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:16 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 02:11:16 INFO - Cleaning up... 02:11:16 INFO - Return code: 0 02:11:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:11:16 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')]} 02:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:16 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')]} 02:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:16 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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:16 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 02:11:16 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 02:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:16 INFO - 'HOME': '/Users/cltbld', 02:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:16 INFO - 'LOGNAME': 'cltbld', 02:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:16 INFO - 'MOZ_NO_REMOTE': '1', 02:11:16 INFO - 'NO_EM_RESTART': '1', 02:11:16 INFO - 'PAGER': '/bin/cat', 02:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:16 INFO - 'PWD': '/builds/slave/test', 02:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:16 INFO - 'SHELL': '/bin/bash', 02:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:16 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:16 INFO - 'USER': 'cltbld', 02:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:16 INFO - 'XPC_FLAGS': '0x0', 02:11:16 INFO - 'XPC_SERVICE_NAME': '0', 02:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:16 INFO - Downloading/unpacking psutil>=0.7.1 02:11:16 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 02:11:16 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 02:11:16 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 02:11:16 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 02:11:16 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 02:11:16 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 02:11:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:11:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:19 INFO - Installing collected packages: psutil 02:11:19 INFO - Running setup.py install for psutil 02:11:20 INFO - building 'psutil._psutil_osx' extension 02:11:20 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 02:11:20 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 02:11:20 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 02:11:20 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 02:11:20 INFO - building 'psutil._psutil_posix' extension 02:11:20 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 02:11:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:11:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:11:20 INFO - ^ 02:11:20 INFO - 1 warning generated. 02:11:20 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 02:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:21 INFO - Successfully installed psutil 02:11:21 INFO - Cleaning up... 02:11:21 INFO - Return code: 0 02:11:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:11:21 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')]} 02:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:21 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')]} 02:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:21 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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:21 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 02:11:21 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 02:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:21 INFO - 'HOME': '/Users/cltbld', 02:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:21 INFO - 'LOGNAME': 'cltbld', 02:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:21 INFO - 'MOZ_NO_REMOTE': '1', 02:11:21 INFO - 'NO_EM_RESTART': '1', 02:11:21 INFO - 'PAGER': '/bin/cat', 02:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:21 INFO - 'PWD': '/builds/slave/test', 02:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:21 INFO - 'SHELL': '/bin/bash', 02:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:21 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:21 INFO - 'USER': 'cltbld', 02:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:21 INFO - 'XPC_FLAGS': '0x0', 02:11:21 INFO - 'XPC_SERVICE_NAME': '0', 02:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:11:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:11:24 INFO - Installing collected packages: mozsystemmonitor 02:11:24 INFO - Running setup.py install for mozsystemmonitor 02:11:24 INFO - Successfully installed mozsystemmonitor 02:11:24 INFO - Cleaning up... 02:11:24 INFO - Return code: 0 02:11:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:24 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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:24 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 02:11:24 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 02:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:24 INFO - 'HOME': '/Users/cltbld', 02:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:24 INFO - 'LOGNAME': 'cltbld', 02:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:24 INFO - 'MOZ_NO_REMOTE': '1', 02:11:24 INFO - 'NO_EM_RESTART': '1', 02:11:24 INFO - 'PAGER': '/bin/cat', 02:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:24 INFO - 'PWD': '/builds/slave/test', 02:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:24 INFO - 'SHELL': '/bin/bash', 02:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:24 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:24 INFO - 'USER': 'cltbld', 02:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:24 INFO - 'XPC_FLAGS': '0x0', 02:11:24 INFO - 'XPC_SERVICE_NAME': '0', 02:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:11:25 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 02:11:25 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 02:11:25 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 02:11:25 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 02:11:25 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 02:11:25 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 02:11:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:11:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:11:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:11:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:11:29 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 02:11:29 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 02:11:29 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 02:11:29 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 02:11:29 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 02:11:29 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 02:11:29 INFO - Downloading docopt-0.6.1.tar.gz 02:11:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:11:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:11:29 INFO - Running setup.py install for blobuploader 02:11:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:11:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:11:29 INFO - Running setup.py install for requests 02:11:30 INFO - Running setup.py install for docopt 02:11:30 INFO - Successfully installed blobuploader requests docopt 02:11:30 INFO - Cleaning up... 02:11:30 INFO - Return code: 0 02:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:30 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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:30 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 02:11:30 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 02:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:30 INFO - 'HOME': '/Users/cltbld', 02:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:30 INFO - 'LOGNAME': 'cltbld', 02:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:30 INFO - 'MOZ_NO_REMOTE': '1', 02:11:30 INFO - 'NO_EM_RESTART': '1', 02:11:30 INFO - 'PAGER': '/bin/cat', 02:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:30 INFO - 'PWD': '/builds/slave/test', 02:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:30 INFO - 'SHELL': '/bin/bash', 02:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:30 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:30 INFO - 'USER': 'cltbld', 02:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:30 INFO - 'XPC_FLAGS': '0x0', 02:11:30 INFO - 'XPC_SERVICE_NAME': '0', 02:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:31 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-G3eTiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:31 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-l5UTI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:31 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-tpaOOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:31 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-jpNTPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:31 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-tPZBXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-aypjGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-0ZrkTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-WTFspw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-K8IvPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-k3e7rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:32 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-X8pBir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-phZzos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-bgkSJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-uyGX29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-mcUc4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-dXG4XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:33 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-4TMOHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:11:33 INFO - Running setup.py install for manifestparser 02:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:11:34 INFO - Running setup.py install for mozcrash 02:11:34 INFO - Running setup.py install for mozdebug 02:11:34 INFO - Running setup.py install for mozdevice 02:11:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:11:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:11:34 INFO - Running setup.py install for mozfile 02:11:34 INFO - Running setup.py install for mozhttpd 02:11:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Running setup.py install for mozinfo 02:11:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Running setup.py install for mozInstall 02:11:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:11:35 INFO - Running setup.py install for mozleak 02:11:35 INFO - Running setup.py install for mozlog 02:11:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for moznetwork 02:11:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for mozprocess 02:11:36 INFO - Running setup.py install for mozprofile 02:11:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for mozrunner 02:11:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for mozscreenshot 02:11:37 INFO - Running setup.py install for moztest 02:11:37 INFO - Running setup.py install for mozversion 02:11:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:11:37 INFO - Cleaning up... 02:11:37 INFO - Return code: 0 02:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:37 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 02:11:37 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 02:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:37 INFO - 'HOME': '/Users/cltbld', 02:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:37 INFO - 'LOGNAME': 'cltbld', 02:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:37 INFO - 'MOZ_NO_REMOTE': '1', 02:11:37 INFO - 'NO_EM_RESTART': '1', 02:11:37 INFO - 'PAGER': '/bin/cat', 02:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:37 INFO - 'PWD': '/builds/slave/test', 02:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:37 INFO - 'SHELL': '/bin/bash', 02:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:37 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:37 INFO - 'USER': 'cltbld', 02:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:37 INFO - 'XPC_FLAGS': '0x0', 02:11:37 INFO - 'XPC_SERVICE_NAME': '0', 02:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-EUPi7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-qKUlBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-ZnCf6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-n46Exu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-3Lu6yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-wRB3Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:38 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)) 02:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:38 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-jw46cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-kKdCV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-rp8Eid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-cUhQ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-V0IPrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-ooQo6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:39 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-4C06Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:40 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-rlXrqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:40 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-tdBaIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:40 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-cN3knA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:40 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-16xelk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:43 INFO - Downloading blessings-1.5.1.tar.gz 02:11:43 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 02:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:43 INFO - Installing collected packages: blessings 02:11:43 INFO - Running setup.py install for blessings 02:11:43 INFO - Successfully installed blessings 02:11:43 INFO - Cleaning up... 02:11:44 INFO - Return code: 0 02:11:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:44 INFO - Reading from file tmpfile_stdout 02:11:44 INFO - Current package versions: 02:11:44 INFO - blessings == 1.5.1 02:11:44 INFO - blobuploader == 1.2.4 02:11:44 INFO - docopt == 0.6.1 02:11:44 INFO - manifestparser == 1.1 02:11:44 INFO - mozInstall == 1.12 02:11:44 INFO - mozcrash == 0.16 02:11:44 INFO - mozdebug == 0.1 02:11:44 INFO - mozdevice == 0.46 02:11:44 INFO - mozfile == 1.2 02:11:44 INFO - mozhttpd == 0.7 02:11:44 INFO - mozinfo == 0.8 02:11:44 INFO - mozleak == 0.1 02:11:44 INFO - mozlog == 3.0 02:11:44 INFO - moznetwork == 0.27 02:11:44 INFO - mozprocess == 0.22 02:11:44 INFO - mozprofile == 0.27 02:11:44 INFO - mozrunner == 6.11 02:11:44 INFO - mozscreenshot == 0.1 02:11:44 INFO - mozsystemmonitor == 0.0 02:11:44 INFO - moztest == 0.7 02:11:44 INFO - mozversion == 1.4 02:11:44 INFO - psutil == 3.1.1 02:11:44 INFO - requests == 1.2.3 02:11:44 INFO - wsgiref == 0.1.2 02:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x105170a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051dd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d90e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, '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.DjIDt8jxFr/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.zZU4anuvKv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 02:11:44 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 02:11:44 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 02:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:44 INFO - 'HOME': '/Users/cltbld', 02:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:44 INFO - 'LOGNAME': 'cltbld', 02:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:44 INFO - 'MOZ_NO_REMOTE': '1', 02:11:44 INFO - 'NO_EM_RESTART': '1', 02:11:44 INFO - 'PAGER': '/bin/cat', 02:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:44 INFO - 'PWD': '/builds/slave/test', 02:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:44 INFO - 'SHELL': '/bin/bash', 02:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:11:44 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:44 INFO - 'USER': 'cltbld', 02:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:44 INFO - 'XPC_FLAGS': '0x0', 02:11:44 INFO - 'XPC_SERVICE_NAME': '0', 02:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:11:44 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)) 02:11:44 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)) 02:11:44 INFO - Cleaning up... 02:11:44 INFO - Return code: 0 02:11:44 INFO - Running post-action listener: _resource_record_post_action 02:11:44 INFO - Running post-action listener: _start_resource_monitoring 02:11:44 INFO - Starting resource monitoring. 02:11:44 INFO - ##### 02:11:44 INFO - ##### Running install step. 02:11:44 INFO - ##### 02:11:44 INFO - Running pre-action listener: _resource_record_pre_action 02:11:44 INFO - Running main action method: install 02:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:45 INFO - Reading from file tmpfile_stdout 02:11:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:45 INFO - Reading from file tmpfile_stdout 02:11:45 INFO - Output received: 02:11:45 INFO - Usage: mozinstall [options] installer 02:11:45 INFO - Options: 02:11:45 INFO - -h, --help show this help message and exit 02:11:45 INFO - -d DEST, --destination=DEST 02:11:45 INFO - Directory to install application into. [default: 02:11:45 INFO - "/builds/slave/test"] 02:11:45 INFO - --app=APP Application being installed. [default: firefox] 02:11:45 INFO - mkdir: /builds/slave/test/build/application 02:11:45 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'] 02:11:45 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 02:12:31 INFO - Reading from file tmpfile_stdout 02:12:31 INFO - Output received: 02:12:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:12:31 INFO - Running post-action listener: _resource_record_post_action 02:12:31 INFO - ##### 02:12:31 INFO - ##### Running run-tests step. 02:12:31 INFO - ##### 02:12:31 INFO - Running pre-action listener: _resource_record_pre_action 02:12:31 INFO - Running main action method: run_tests 02:12:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:12:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:12:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:12:31 INFO - 2015-11-15 02:12:31.045 screenresolution[1980:23190] starting screenresolution argv=screenresolution get 02:12:31 INFO - 2015-11-15 02:12:31.049 screenresolution[1980:23190] Display 0: 1600x1200x32@60 02:12:31 INFO - 2015-11-15 02:12:31.057 screenresolution[1981:23192] starting screenresolution argv=screenresolution list 02:12:31 INFO - Available Modes on Display 0 02:12:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:12:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:12:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:12:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:12:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:12:31 INFO - Intel HD Graphics 3000: 02:12:31 INFO - Chipset Model: Intel HD Graphics 3000 02:12:31 INFO - Type: GPU 02:12:31 INFO - Bus: Built-In 02:12:31 INFO - VRAM (Total): 512 MB 02:12:31 INFO - VRAM (Dynamic, Max): 10 02:12:31 INFO - Vendor: Intel (0x8086) 02:12:31 INFO - Device ID: 0x0116 02:12:31 INFO - Revision ID: 0x0009 02:12:31 INFO - Displays: 02:12:31 INFO - Display: 02:12:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:12:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:12:31 INFO - Display Serial Number: 1600x1200 60 02:12:31 INFO - Main Display: Yes 02:12:31 INFO - Mirror: Off 02:12:31 INFO - Online: Yes 02:12:31 INFO - Rotation: Supported 02:12:31 INFO - Return code: 0 02:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:31 INFO - Python 2.7.3 02:12:31 INFO - Return code: 0 02:12:31 INFO - grabbing minidump binary from tooltool 02:12: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')]} 02:12:31 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 0x1051259f0>, '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 0x104e84cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050ef990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12:31 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 02:12:31 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 02:12:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:31 INFO - Return code: 0 02:12:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:12:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:12:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:31 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/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] in /builds/slave/test/build 02:12:31 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/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0066 --webServer localhost 02:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DjIDt8jxFr/Render', 02:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:31 INFO - 'HOME': '/Users/cltbld', 02:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:31 INFO - 'LOGNAME': 'cltbld', 02:12:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:31 INFO - 'MOZ_NO_REMOTE': '1', 02:12:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:31 INFO - 'NO_EM_RESTART': '1', 02:12:31 INFO - 'PAGER': '/bin/cat', 02:12:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:31 INFO - 'PWD': '/builds/slave/test', 02:12:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:31 INFO - 'SHELL': '/bin/bash', 02:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zZU4anuvKv/Listeners', 02:12:31 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 02:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:31 INFO - 'USER': 'cltbld', 02:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:31 INFO - 'XPC_FLAGS': '0x0', 02:12:31 INFO - 'XPC_SERVICE_NAME': '0', 02:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:12:31 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/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] with output_timeout 3600 02:12:31 INFO - mozversion INFO | application_buildid: 20151115004211 02:12:31 INFO - mozversion INFO | application_changeset: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 02:12:31 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:12:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:31 INFO - mozversion INFO | application_name: Firefox 02:12:31 INFO - mozversion INFO | application_remotingname: firefox-dev 02:12:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:12:31 INFO - mozversion INFO | application_vendor: Mozilla 02:12:31 INFO - mozversion INFO | application_version: 44.0a2 02:12:31 INFO - mozversion INFO | platform_buildid: 20151115004211 02:12:31 INFO - mozversion INFO | platform_changeset: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 02:12:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:12:31 INFO - mozversion INFO | platform_version: 44.0a2 02:12:31 INFO - 2015-11-15 02:12:31,784 DEBUG : using testdate: 1447582351 02:12:31 INFO - 2015-11-15 02:12:31,784 DEBUG : actual date: 1447582351 02:12:31 INFO - 2015-11-15 02:12:31,796 INFO : starting webserver on 'localhost:49666' 02:12:31 INFO - 2015-11-15 02:12:31,797 INFO : Starting test suite t-yosemite-r5-0066 02:12:31 INFO - 2015-11-15 02:12:31,797 INFO : Starting test dromaeo_css 02:12:31 INFO - 2015-11-15 02:12:31,797 DEBUG : operating with platform_type : mac_ 02:12:31 INFO - 2015-11-15 02:12:31,798 INFO : Initialising browser for dromaeo_css test... 02:12:31 INFO - 2015-11-15 02:12:31,831 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpMqLIwt/profile http://localhost:49666/getInfo.html 02:12:34 INFO - 2015-11-15 02:12:34,818 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:12:34 INFO - 2015-11-15 02:12:34,818 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:12:34 INFO - 2015-11-15 02:12:34,818 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:12:34 INFO - 2015-11-15 02:12:34,818 DEBUG : BROWSER_OUTPUT: __metrics 02:12:34 INFO - 2015-11-15 02:12:34,836 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:35 INFO - 2015-11-15 02:12:35,847 INFO : Browser initialized. 02:12:35 INFO - 2015-11-15 02:12:35,848 INFO : Running cycle 1/1 for dromaeo_css test... 02:12:35 INFO - 2015-11-15 02:12:35,848 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpMqLIwt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:12:48 INFO - 2015-11-15 02:12:48,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 199835648 02:12:48 INFO - 2015-11-15 02:12:48,229 DEBUG : BROWSER_OUTPUT: 02:13:39 INFO - 2015-11-15 02:13:39,975 DEBUG : BROWSER_OUTPUT: 1447582419967 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] 02:15:50 INFO - 2015-11-15 02:15:50,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49666/tests/dromaeo/cssquery-ext.html) 02:15:51 INFO - 2015-11-15 02:15:51,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 314789888 02:15:51 INFO - 2015-11-15 02:15:51,633 DEBUG : BROWSER_OUTPUT: 02:18:54 INFO - 2015-11-15 02:18:54,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-ext.html (next: http://localhost:49666/tests/dromaeo/cssquery-jquery.html) 02:18:55 INFO - 2015-11-15 02:18:55,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 340488192 02:18:55 INFO - 2015-11-15 02:18:55,246 DEBUG : BROWSER_OUTPUT: 02:21:57 INFO - 2015-11-15 02:21:57,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49666/tests/dromaeo/cssquery-mootools.html) 02:21:58 INFO - 2015-11-15 02:21:58,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 304287744 02:21:58 INFO - 2015-11-15 02:21:58,168 DEBUG : BROWSER_OUTPUT: 02:25:00 INFO - 2015-11-15 02:25:00,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49666/tests/dromaeo/cssquery-prototype.html) 02:25:01 INFO - 2015-11-15 02:25:01,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 300412928 02:25:01 INFO - 2015-11-15 02:25:01,006 DEBUG : BROWSER_OUTPUT: 02:28:04 INFO - 2015-11-15 02:28:04,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49666/tests/dromaeo/cssquery-yui.html) 02:28:04 INFO - 2015-11-15 02:28:04,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 301703168 02:28:04 INFO - 2015-11-15 02:28:04,990 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/dromaeo/cssquery-yui.html (next: http://localhost:49666/tests/dromaeo/cssquery-dojo.html) 02:31:07 INFO - 2015-11-15 02:31:07,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 345030656 02:31:07 INFO - 2015-11-15 02:31:07,918 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,919 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:31:07 INFO - 2015-11-15 02:31:07,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:31:07 INFO - 2015-11-15 02:31:07,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:31:07 INFO - 2015-11-15 02:31:07,919 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:31:07 INFO - 2015-11-15 02:31:07,920 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2481.1564068216803;2498.350428888489;2507.7492250774926;2547.7707006369446;2552.0302285131647;4205.810738516767;4256.297710877705;4292.527821939584;4317.15815415994;4317.222899878021;4221.915561688765;4224.831006759726;4285.078708077763;4292.742435453867;4312.159128969852;3754.530683664542;3754.8685795997144;3844.2503711776217;3901.648851603355;3968.841246350157;3765.585785563586;3864.7487913285686;3915.549711783153;3934.763914165145;4009.3384591542363;3950.6641935435523;3956.960430395688;3989.5611482736876;4040.9797951010205;4062.2890994076065;3952.822123004472;3954.4859168307935;3980.024893901013;3991.680665546764;4066.0648050948153;3564.6613571710645;3760.4735337052834;3777.508923839883;3865.768053916774;3879.049632839944;4061.1471590965934;4081.1225586499045;4196.496420429568;4210.642095421893;4215.45199124115;4434.334849772527;4449.777511124431;4500.842470513517;4554.3851580036935;4557.817687292504;4287.078278170208;4493.056458143794;4564.246899261618;4620.468646105707;4621.098885717286;4111.8972025699295;4228.429162063144;4256.5105012923605;4402.3176407656865;4411.338299255138;4601.769911504478;4636.86089417318;4681.7425041622355;4689.296605509201;4730.645201609893;4293.74237545742;4326.891827704332;4408.845690400821;4499.77501124949;4534.614557762628;4442.577955094261;4537.523560026216;4575.016371480147;4605.263157894721;4657.417822772153;4506.1663592235545;4567.223571992769;4613.469451013109;4616.330632058332;4676.953230467651;4257.084726783756;4336.241157797373;4588.6099681526775;4651.511591282867;4706.270528068155;3454.4300190468293;3546.858125674996;3547.3260080584605;3566.928661426809;3595.478655594924;3143.732782713449;3182.44307246231;3213.4376484115187;3225.7903236289567;3272.0511051794715;4071.9796401017807;4092.9181416371507;4157.958420415757;4218.135282267128;4271.487421509377;4194.412782210493;4425.557444255549;4435.844745433894;4487.371767952489;4738.763061846894;4140.834366625361;4160.479940007499;4211.494620645542;4295.291276939332;4325.1565944641125;3971.185906889081;3996.320625493673;4133.731307465006;4136.834526618902;4141.213169497786;4496.258117410591;4505.48186958504;4568.908621827479;4597.954020459752;4742.193827049341;4388.561143885586;4501.819927202875;4547.840825571221;4579.221532339577;4629.652776041878;4503.572160644733;4540.841070562515;4551.977240113778;4685.156671798973;4694.6244300456565;4316.395704601421;4355.673324500612;4424.889377765453;4481.686281960362;4495.2358099122575;4522.4573051234065;4550.590446859798;4618.376519169869;4638.489766125656;4686.671932964659;4418.867433976986;4450.955490445054;4529.048899731093;4570.565796249351;4597.93103103447;4089.1412803311637;4257.74453532789;4324.005478739845;4386.934195986999;4452.042810795694;4326.2212801696;4335;4389.802458889421;4443.044745379759;4474.351219073281;4407.823687052611;4457.375967364636;4502.099580083931;4524.02733412318;4571.885702857455;4275.529691733845;4281.828726850891;4315.007548263854;4352.042550638855;4360.062586543908 02:31:07 INFO - 2015-11-15 02:31:07,920 DEBUG : BROWSER_OUTPUT: |1;ext.html;438.91002344519376;442.41601086565737;444.82207117153143;452;470.77638121892085;25549.616755748655;27199;31456.842715786388;31943.520847187312;32447.188820279447;33813.154671133234;34690.65309346906;35215.82392088036;35290.294194116104;35340.46989295162;6683.465322774191;7245.5290406123695;7317.890231646529;7352.411807055422;7429.8483735021155;6691.36432038958;6811.761588344409;8580.313574913991;8833.779155521099;8888.333374996868;8405.453645513022;8462.23839854413;8797.472151670889;8805.339599530029;8824.02935677075;6930.27232140623;7073.787786366417;8539.444936079166;8655.567221638892;8671.69649062283;6556.442702370305;8488.575571221476;8808.03111657717;8815.20663140314;8843.513606751627;31571.21071973196;31938.520922186184;32230.83884580562;32624.836875815705;32672.346553068804;2385.3440303916386;2423.6970378702663;2464.322311364371;2626.2121363591036;2735.6990731019573;22065;22276.55446891053;22412.55174896493;22700.091996320127;23568.175113871104;1702.8722845786492;1741.8954862708151;1749.1953701297418;1769.78762548495;1798.7751531058618;231666;232697;232824;233964;235481;44065.339019914725;45164.54835451669;45730;50558;51047.7447612767;52794.47205527972;53619;53934;54013.459865400844;54079.45920540823;13631.863681363258;13874.93062534681;13875.930620346833;13879.514217002357;13890.097143685629;10406.947965260126;10418.68743937683;10595.470226488798;10596.89403105959;10700.839487407695;16213.756793648105;16341.673166536602;16558.420455284006;16846.157692115346;16933.238004289837;6810.684367315137;6858.5199036068;6968.3728464438445;6998.970298613447;7038.612876291751;710.0804458226609;719.8848184290489;729.6643543969833;830.9529992209859;849.6888463379597;21917.67123493117;22697;22767.544649106923;22974.65538016931;23063.308100757004;751.0311697909744;846.7502086884384;850.8128211793396;923.316745608245;984.625842179967;8994.955025224832;11676.154395925765;11847.763044739057;11856.407179640983;12055;341423;352236;352873;353338;356461;39450.80274598609;43870.34194487085;44509.77745111254;44665;45260.3210951836;1050.495762034228;1133.6032388664066;1140.5209811878865;1146.6846617180342;1147.581132886507;20738.792612073685;21825.672614910472;23005.88497057504;23099;23149.537009259384;38235.61764382321;38973.805130974164;39710.404343934286;40376.79811600923;40993.385099224135;157188;159150;159824;161502;162284;24088;24244.63633045541;24533.754662453146;24969.87515062413;25335.6199657009;33201.83399082989;33417.33165336631;34438.655613443545;34820.82589587036;35623.28753424865;29075.273118172216;29330.120096397142;29354.853225733736;29619.555706664847;29907.401851962404;23581;23674;23737.762622374245;23738.169164079176;23805.285841424786;28900.855495722386;29566.556501652063;29759;29803.254918627208;29855.850720747127;24809.62785558254;25382.873085634452;25721.5275937746;25761;25822.741772582034;19075.90462047681;19235;19521.902390487958;19721.40835774929;19914.60170796605 02:31:07 INFO - 2015-11-15 02:31:07,920 DEBUG : BROWSER_OUTPUT: |2;jquery.html;267.0839022154011;271.531607976241;275.6857182811595;279.55271565495195;284.4055923120678;8238.423310368276;11135.276207046536;13014.349282535872;14400.639984000405;14588.927055364722;14754.926225368885;14773.48292809752;14825.777613335782;14878.851211487881;15166.317515711791;4235.131797981407;4242.512111107224;4364.738115713068;4417.359482874981;4431.711938723989;3350.8827191048317;3351.664833516641;3467.2198755279987;4257.212415703089;4585.082983403316;4759.619230461555;4885.364902562662;4940.851774446773;4941.4811444798315;4945.381827271591;4768.833090841838;4779.641526885497;4784.665073444878;4794.161021821167;4867.440244371889;4231.090315582164;4302.849400270976;4315.82736690532;4317.460317460317;4319.33050377192;17744.55638609045;18487;18527.722084168614;18802.623947520973;18841.811581884143;1596.2497626115708;1626.5039163055264;1644.7697322374756;1700.7363858601936;1716.3220527891413;10469.162467002621;10612.575496980111;10726.785464290671;10770.192235582284;11103.167262455348;1287.485005997599;1325.4631874090912;1345.4685399267332;1355.4171706166344;1377.393946663465;51084.48915510871;51905.74047129778;52014.21978670323;52175.73912130415;52221.21668174981;8598.441101328393;8633.179847914564;8665.306775457948;8731.126887311219;8731.345149113715;10969.890301096886;10971.286866353821;10972.561097556169;11003.394813285346;11006.064484518745;6634.966825165843;6857.382835544825;6882.655867206619;6955.513114082067;7008.859822803515;6857.451403887677;6993.615351155633;7044.366007059287;7046.224915259318;7069.434445244368;4827.95172048275;4916.582090522345;4965.503449655078;5039.269305950616;5096.464871188546;1301.1412467771415;1353.35715535122;1430.5064752660317;1435.0743770268118;1499.6175975126273;332.34693826630786;341.0926934354605;347.92867462170193;370.63862733834833;377.9659830615258;7552.962235188789;9061.41100828444;9421.481818499911;9512.619495220113;9667.516624168764;349.135888675526;359.55415285046877;371.51331755399974;380.6326894546776;385.3410667758109;4923.384576927884;4931.778069986859;4960.305557221992;5116.130257856099;5178.223266509978;438994;445290;446637;449983;486348;54943.725281373336;56086.43913560894;57341.713291433276;57561;58050.419495804505;402.6879168644324;411.34390646918115;411.72208759087493;417.16566866267465;418.04059683027526;8111.269985701315;8312.5428101455;8380.20388063133;8475.152484751723;8654.874866267344;26152.8692356537;26896;27005.324866878484;27515.58726619142;27937.720622794324;34730.82634586912;36266.456003159445;36769.816150919076;38755.80622096871;39067;4444.622207112432;4549.65877559191;4801.807927682854;4948.604111670986;4972.353594032753;7773.1060927994;8755.60599772999;8882.822343553222;8926.86609700842;9248.260139188715;6701.932980670326;7702.922970770221;7902.802429939297;8117.985251843519;8133.715319963773;7421.146568144516;7623.618819058914;7666.578338191453;7861.095973963067;8085.71699990521;7684.1547429783795;7853.214678532329;7985.880211796712;8176.305014073871;8274.544900030556;4764.595009424238;4800.951990480051;4980.32765576657;5005.974970125126;5041.697498150123;7301.963490182515;7768.223177682413;7993.240642138988;8035.799105022421;8188 02:31:07 INFO - 2015-11-15 02:31:07,924 DEBUG : BROWSER_OUTPUT: |3;mootools.html;545.9699716515595;1171.9355435451052;1331.0216990511972;1339.1496399786135;1474.9041312314691;5443.4828691274315;5609.186667933152;5676.858078548038;5956.5234781217505;5958.851028724284;5848.853778655525;5889.587728858982;5928.962431574479;6082.756689732405;6096.146539484475;1683;1686.1990554486642;1691.4671878358308;1713.1348668922176;1715.4682048564923;1678.6474840283556;1716.6824137534534;1724.34474899538;1729.161356741979;1766.222861940742;1733.679269335177;1765.8234176582303;1778.786545614528;1782.162383679675;1788.2757483219316;1720.664470428267;1727.8876873003278;1742.0157610949773;1771.8139595342432;1779.17268470162;1713.76864123343;1745.9912700436544;1780.5904641932427;1782.8128046555184;1786.7855857297207;5394.136938089926;6013.969930150365;6040.335563088057;6049.425304596057;6064.727087281083;3124.562561241428;3328.400887840188;3641.435577485494;3642.05306620278;3726.869559565402;2200.6038912995655;2211.2813335665974;2286.7255929288426;2290.0496294037953;2291.942701432461;564.7797359029981;659.7361055577759;668.5954997226705;669.7388018672722;702.0942983551213;7812.296893279632;7862.8427431451055;7891.723789667334;7895.092064412609;7899.289063984269;3404.7786893852317;3468.4623883297622;3469.462233353834;3534;3563.8396272167815;6927.238003819576;6929.5842249465195;6932.168139823153;6932.480063995221;6936.514443988974;3748.700103991674;3810.3903375459795;3830.636089571486;3846.0384903774057;3846.480725102131;3496.300739851989;3497.4753786931656;3502.124468882779;3503.5445392098864;3506.6142724300307;2878.1221727372936;2909.3744844858456;2919.080489645755;2959.363736796599;2960.0231923465203;928.9489078100769;939.0281059103795;952.1335584618103;959.6017652674202;964.8359778837614;817.6770175780533;836.8493671139254;867.2238346679812;872.9825403491894;883.1257055514994;5528.281323427928;5705.087186050212;5745.88508229833;5768.394318596571;5775.133729940542;368.0871438831712;375.4312216991206;380.16743332102607;382.273680007987;388.970827187962;4316.223079845595;4330.826766929351;4470.977645111819;4576.977115114403;4584.587387135107;7002.474814388839;7038.049863268496;7083.5041547091205;7171.103612048494;7174.748883789147;6869.484788640772;6914.481413893978;7045.859082818315;7090.397316228075;7192.496525243183;4939.481354457802;5143.717095559706;5314.335708036496;5647.209390685307;5648;5058.974705126451;5346.572274218131;5379.112446446449;5620.437956204347;5623.128415095667;5917.230760001173;6097.390260973867;6140.478059364826;6395.808125756234;6428.19647544057;6396.200474940632;6437.7103030362805;6445.065465507381;6627.271000190071;6639.236487803964;5598.412166722435;5720.399358067343;5759.193712880284;5849.970750146393;5870.26621672291;5772.5959182856795;5813.128030795415;5814.331351894417;5915.822525324247;5935.584509084322;5113.386393632639;5174.534291913746;5287.947120528899;5359.973200133974;5515.834524964257;5033.84898453047;5148.279240906351;5254.579633629377;5290.81482148123;5469.206964989975;5278.656887302313;5412.485813847678;5421.647592906448;5423.29497165366;5446.891062178814;4739.075880203465;4749.477557468606;4846.975765121152;4858.076965376567;4862.90274194507;4804.567588917014;4985;4985.875353116201;5010.148274793367;5012.8496145115705 02:31:07 INFO - 2015-11-15 02:31:07,925 DEBUG : BROWSER_OUTPUT: |4;prototype.html;233.87838324071484;235.57008459561294;236.41605235069383;241.62548050521687;248.33941715038003;4684.6252299816015;4707.1762441572755;4711.976440117799;4817.397825271841;4819.638527110467;4460;4628.745419001953;4680.25115981443;4716.434027916646;4720.409948756405;3481.860725570974;3548.840302186395;3557.839897204619;3561.145325121965;3570.7143428525787;3322.7840190387546;3505.526753888231;3515.876944306937;3579.284143171363;3585.1754096557806;3281.96718032819;3425.5375524304272;3476.1135910342828;3519.1905861651835;3549.6805287524116;3402.166469215058;3411.3688967541084;3499.335126326003;3512.5784905811465;3533.2580158166943;2932.428176505582;3049.40536595364;3049.6797836227097;3058.4341896749174;3062.525308577174;4399.208142534342;4542.454905411339;4569.13186494565;4573.656975726801;4575.176468235716;3757.5866654667966;3931.783751893645;3977.3238549446664;4057.2899742544937;4059;4751.073540659539;4909.3126962225315;4921.729304888229;4922.114019476493;4923.75381230937;3172.6034245719284;3273.9017829465156;3280.6883346082086;3285.0309158798214;3289.079057863778;4780.593649539794;4975.154223781966;5023.673461225045;5025.195968644999;5048.268001139851;3155.5739975103065;3265.6571060038355;3282.2450836307785;3286.917827054343;3291.489819078047;3256.5115232715284;3264.396086723964;3304.041827869939;3337.632860385356;3344.414727422691;3786.4320351947426;3875.3024455597697;3910.1788624389196;3919.784411857318;3934.5278566572197;4740.478547359788;4760.64295177863;4901.754912254373;4923.556879880828;4928.383952005999;1182.3319824299244;1190.678516800459;1208.9818652720217;1209.0448545649015;1210.0259291270436;759.3090287838041;762.5805806806235;773.0954782904016;774.2760518914832;786.0449553792056;4579.839705610288;4714.504976977437;4729.881752956135;4731.2903064539905;4737.360456338351;5035.269885866529;5061.822836200715;5111.488851114858;5161.612879034013;5165.535101840853;4623.006053698471;4675.275332323496;4700.482946875841;4700.7179569225955;4725.480197178307;2725.8909643614033;2774.4867199568143;2858.6712528059124;2863.3414314707734;2864.255293623673;5109.6678715883345;5132.384113906355;5241.42344342122;5242.7378631068295;5253.4221235664045;5167.4832516748775;5180.559652429511;5271;5280.9471905281225;5290.576753859682;5098.5411312982005;5131.794728210904;5227.712475813791;5229.607779416559;5245.3705555332845;4953.1676377314525;4980.825671101494;5081.92377114351;5118.43697193301;5136.768845401891;5107.591392688651;5115.053715062725;5116.258142569232;5121.820736274212;5122.564582010571;4991.301217829579;5192.42883282831;5198.194279886624;5285.154375299933;5293.470652934676;3135.3729254148807;3159.241781972264;3203.0550987459224;3339.682730140633;3345.448001079892;4897.4857639947295;4987.027529631687;5018.447970723145;5083.669561478492;5098.1842905135;4910.8281210157475;4923.286123512143;4947.431045429822;4967.155583550732;4968.751562421792;4737.9052418952115;4838.758062096811;4948.703077815343;4949.604031677529;4953.257011448168;4767.809287628595;4774.069056533943;4911.9754401227765;4933.703977761345;4938.160512712776;4871.48849370811;5009.824656137163;5010.649254552146;5014.749262536931;5015.949840501694;4772.355731976278;4906.803727850989;4907.656464047625;4911.3369695090705;4946.530079642428 02:31:07 INFO - 2015-11-15 02:31:07,929 DEBUG : BROWSER_OUTPUT: |5;yui.html;523.382408757666;563.0540691638048;592.0762768501146;608.6439432931735;619.1764952613025;10337.483125843706;10512.421816800073;10565.366078035324;10831.458427078644;10899.891001089996;10103.444310562934;10233.846492302602;10270.897291027088;10588.100011499013;10621.681349559525;553.4520824383851;599.7900734742849;701.7438634898276;707.8867381219006;734.2620666230457;601.527800676469;691.5781373362245;711.0933559711383;725.9128904531464;726.9709211631555;725.1805459830384;734.8897665350213;735.334522257358;748.2405358561065;751.0461713623695;575.1832397994857;619.3589634728035;700.7092056796423;736.3483317264206;758.9696412143535;546.4999525434223;552.1000768746917;558.1460365640577;565.2482198675751;571.4885177765918;9676.56455459506;9842.065003824626;9903.60385584583;10045.14616257619;10069.949650251776;9091.81816363669;9110.77223069422;9174.541272936392;9433.858492122623;9824.508774561315;7170.928290717078;7494.6627401767055;7629.19893411195;7759.203980099503;7779.105402878628;2599.6750406199226;2599.8440093594445;2606.8696565171854;2648.576227803542;2651.7480839320233;37689.623103768885;37810.24379512422;37909.620903790885;38037;38254.42618360727;6887.621180835002;7109.786706398816;7284.854302913912;7328.633568321563;7357.41140708742;15624.062556246661;15690.68618627621;15697.136657483949;15733.44932927365;15748;5655.519280861091;5657.51911087554;5730.598858079978;5759.568032397503;5987.2815262168815;3024.9546256806166;3059.98470007653;3063;3142;3216.758743094277;2312.329424466886;2359.351178425912;2361.2207971369407;2362.055177928842;2363.3618922890723;332.2739813507494;341.5900918897333;341.6481024544723;370.75900664567706;385.77046657238895;390.4689622113923;404.90484736086995;423.38397631446173;458.8574449620421;462.00824873096474;5533.3083364579425;6049.141790486088;6061.212042434456;6109.8472538186015;6186.288576813634;378.42857285499093;396.4469564956869;457.732226647415;464.87913142582494;480.0998128509045;2314.2941402872284;2483.255023492945;2615.803814713904;2720.6327145835453;2721.4693134838913;44752.10495790131;45763;45780.542194578295;45997.310040349425;47895.28157077647;39504;40207;40569.797151014056;40808;41064.589354106676;36819;37002.62997369992;37459.43810842894;37843.62156378401;38147.42778858319;6140.355262697352;6153.138560601609;6321.11504389395;6516.869662606816;6579.868402632016;25163.622545662194;26300.21099367022;26411.339716507242;27789.305267368476;27989.160325190278;36145.45781813222;36454.453183201746;37051.44422833714;38235.61764382321;38273.04317392087;6032.4570788629235;6245.875082498415;6330.3669633036325;6399.816034033719;6494.837629059311;8695.434796738191;8712.738617841474;8736.650533978569;8972.820543588961;9024.86462703073;8118.037332277024;8171.346292296721;8269.338452923632;8417.116202798617;8445.619947102272;8296.668133274601;8306.54314012735;8313.6674533018;8340.833183336421;8443.24010839003;8123.79690507742;8218.753437396888;8280.420370574244;8297;8300.750977470685;6963.79108626742;6965.79102626922;7076.22161562238;7220.241874603091;7276.381507571916;6966.721331146698;7061.788146355618;7070.71717131309;7204.063471748848;7284.125904891447 02:31:07 INFO - 2015-11-15 02:31:07,929 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:31:07 INFO - 2015-11-15 02:31:07,929 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:31:07 INFO - 2015-11-15 02:31:07,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1050 02:31:07 INFO - 2015-11-15 02:31:07,929 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:31:07 INFO - 2015-11-15 02:31:07,930 DEBUG : BROWSER_OUTPUT: __startTimestamp1447583467911__endTimestamp 02:31:07 INFO - 2015-11-15 02:31:07,930 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,930 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:31:07 INFO - 2015-11-15 02:31:07,930 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:31:07 INFO - 2015-11-15 02:31:07,930 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,931 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4217.54 Median:4324.01 stddev:453.99 (10.5%) stddev-sans-first:434.47 02:31:07 INFO - 2015-11-15 02:31:07,931 DEBUG : BROWSER_OUTPUT: Values: 2481.2 2498.4 2507.7 2547.8 2552.0 4205.8 4256.3 4292.5 4317.2 4317.2 4221.9 4224.8 4285.1 4292.7 4312.2 3754.5 3754.9 3844.3 3901.6 3968.8 3765.6 3864.7 3915.5 3934.8 4009.3 3950.7 3957.0 3989.6 4041.0 4062.3 3952.8 3954.5 3980.0 3991.7 4066.1 3564.7 3760.5 3777.5 3865.8 3879.0 4061.1 4081.1 4196.5 4210.6 4215.5 4434.3 4449.8 4500.8 4554.4 4557.8 4287.1 4493.1 4564.2 4620.5 4621.1 4111.9 4228.4 4256.5 4402.3 4411.3 4601.8 4636.9 4681.7 4689.3 4730.6 4293.7 4326.9 4408.8 4499.8 4534.6 4442.6 4537.5 4575.0 4605.3 4657.4 4506.2 4567.2 4613.5 4616.3 4677.0 4257.1 4336.2 4588.6 4651.5 4706.3 3454.4 3546.9 3547.3 3566.9 3595.5 3143.7 3182.4 3213.4 3225.8 3272.1 4072.0 4092.9 4158.0 4218.1 4271.5 4194.4 4425.6 4435.8 4487.4 4738.8 4140.8 4160.5 4211.5 4295.3 4325.2 3971.2 3996.3 4133.7 4136.8 4141.2 4496.3 4505.5 4568.9 4598.0 4742.2 4388.6 4501.8 4547.8 4579.2 4629.7 4503.6 4540.8 4552.0 4685.2 4694.6 4316.4 4355.7 4424.9 4481.7 4495.2 4522.5 4550.6 4618.4 4638.5 4686.7 4418.9 4451.0 4529.0 4570.6 4597.9 4089.1 4257.7 4324.0 4386.9 4452.0 4326.2 4335.0 4389.8 4443.0 4474.4 4407.8 4457.4 4502.1 4524.0 4571.9 4275.5 4281.8 4315.0 4352.0 4360.1 02:31:07 INFO - 2015-11-15 02:31:07,931 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,931 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38518.90 Median:30682.12 stddev:68815.07 (224.3%) stddev-sans-first:68948.71 02:31:07 INFO - 2015-11-15 02:31:07,933 DEBUG : BROWSER_OUTPUT: Values: 438.9 442.4 444.8 452.0 470.8 25549.6 27199.0 31456.8 31943.5 32447.2 33813.2 34690.7 35215.8 35290.3 35340.5 6683.5 7245.5 7317.9 7352.4 7429.8 6691.4 6811.8 8580.3 8833.8 8888.3 8405.5 8462.2 8797.5 8805.3 8824.0 6930.3 7073.8 8539.4 8655.6 8671.7 6556.4 8488.6 8808.0 8815.2 8843.5 31571.2 31938.5 32230.8 32624.8 32672.3 2385.3 2423.7 2464.3 2626.2 2735.7 22065.0 22276.6 22412.6 22700.1 23568.2 1702.9 1741.9 1749.2 1769.8 1798.8 231666.0 232697.0 232824.0 233964.0 235481.0 44065.3 45164.5 45730.0 50558.0 51047.7 52794.5 53619.0 53934.0 54013.5 54079.5 13631.9 13874.9 13875.9 13879.5 13890.1 10406.9 10418.7 10595.5 10596.9 10700.8 16213.8 16341.7 16558.4 16846.2 16933.2 6810.7 6858.5 6968.4 6999.0 7038.6 710.1 719.9 729.7 831.0 849.7 21917.7 22697.0 22767.5 22974.7 23063.3 751.0 846.8 850.8 923.3 984.6 8995.0 11676.2 11847.8 11856.4 12055.0 341423.0 352236.0 352873.0 353338.0 356461.0 39450.8 43870.3 44509.8 44665.0 45260.3 1050.5 1133.6 1140.5 1146.7 1147.6 20738.8 21825.7 23005.9 23099.0 23149.5 38235.6 38973.8 39710.4 40376.8 40993.4 157188.0 159150.0 159824.0 161502.0 162284.0 24088.0 24244.6 24533.8 24969.9 25335.6 33201.8 33417.3 34438.7 34820.8 35623.3 29075.3 29330.1 29354.9 29619.6 29907.4 23581.0 23674.0 23737.8 23738.2 23805.3 28900.9 29566.6 29759.0 29803.3 29855.9 24809.6 25382.9 25721.5 25761.0 25822.7 19075.9 19235.0 19521.9 19721.4 19914.6 02:31:07 INFO - 2015-11-15 02:31:07,933 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,933 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22813.44 Median:4762.11 stddev:74181.23 (1557.7%) stddev-sans-first:74370.00 02:31:07 INFO - 2015-11-15 02:31:07,935 DEBUG : BROWSER_OUTPUT: Values: 267.1 271.5 275.7 279.6 284.4 8238.4 11135.3 13014.3 14400.6 14588.9 14754.9 14773.5 14825.8 14878.9 15166.3 4235.1 4242.5 4364.7 4417.4 4431.7 3350.9 3351.7 3467.2 4257.2 4585.1 4759.6 4885.4 4940.9 4941.5 4945.4 4768.8 4779.6 4784.7 4794.2 4867.4 4231.1 4302.8 4315.8 4317.5 4319.3 17744.6 18487.0 18527.7 18802.6 18841.8 1596.2 1626.5 1644.8 1700.7 1716.3 10469.2 10612.6 10726.8 10770.2 11103.2 1287.5 1325.5 1345.5 1355.4 1377.4 51084.5 51905.7 52014.2 52175.7 52221.2 8598.4 8633.2 8665.3 8731.1 8731.3 10969.9 10971.3 10972.6 11003.4 11006.1 6635.0 6857.4 6882.7 6955.5 7008.9 6857.5 6993.6 7044.4 7046.2 7069.4 4828.0 4916.6 4965.5 5039.3 5096.5 1301.1 1353.4 1430.5 1435.1 1499.6 332.3 341.1 347.9 370.6 378.0 7553.0 9061.4 9421.5 9512.6 9667.5 349.1 359.6 371.5 380.6 385.3 4923.4 4931.8 4960.3 5116.1 5178.2 438994.0 445290.0 446637.0 449983.0 486348.0 54943.7 56086.4 57341.7 57561.0 58050.4 402.7 411.3 411.7 417.2 418.0 8111.3 8312.5 8380.2 8475.2 8654.9 26152.9 26896.0 27005.3 27515.6 27937.7 34730.8 36266.5 36769.8 38755.8 39067.0 4444.6 4549.7 4801.8 4948.6 4972.4 7773.1 8755.6 8882.8 8926.9 9248.3 6701.9 7702.9 7902.8 8118.0 8133.7 7421.1 7623.6 7666.6 7861.1 8085.7 7684.2 7853.2 7985.9 8176.3 8274.5 4764.6 4801.0 4980.3 5006.0 5041.7 7302.0 7768.2 7993.2 8035.8 8188.0 02:31:07 INFO - 2015-11-15 02:31:07,935 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,936 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4156.60 Median:5330.45 stddev:2152.03 (40.4%) stddev-sans-first:2140.93 02:31:07 INFO - 2015-11-15 02:31:07,936 DEBUG : BROWSER_OUTPUT: Values: 546.0 1171.9 1331.0 1339.1 1474.9 5443.5 5609.2 5676.9 5956.5 5958.9 5848.9 5889.6 5929.0 6082.8 6096.1 1683.0 1686.2 1691.5 1713.1 1715.5 1678.6 1716.7 1724.3 1729.2 1766.2 1733.7 1765.8 1778.8 1782.2 1788.3 1720.7 1727.9 1742.0 1771.8 1779.2 1713.8 1746.0 1780.6 1782.8 1786.8 5394.1 6014.0 6040.3 6049.4 6064.7 3124.6 3328.4 3641.4 3642.1 3726.9 2200.6 2211.3 2286.7 2290.0 2291.9 564.8 659.7 668.6 669.7 702.1 7812.3 7862.8 7891.7 7895.1 7899.3 3404.8 3468.5 3469.5 3534.0 3563.8 6927.2 6929.6 6932.2 6932.5 6936.5 3748.7 3810.4 3830.6 3846.0 3846.5 3496.3 3497.5 3502.1 3503.5 3506.6 2878.1 2909.4 2919.1 2959.4 2960.0 928.9 939.0 952.1 959.6 964.8 817.7 836.8 867.2 873.0 883.1 5528.3 5705.1 5745.9 5768.4 5775.1 368.1 375.4 380.2 382.3 389.0 4316.2 4330.8 4471.0 4577.0 4584.6 7002.5 7038.0 7083.5 7171.1 7174.7 6869.5 6914.5 7045.9 7090.4 7192.5 4939.5 5143.7 5314.3 5647.2 5648.0 5059.0 5346.6 5379.1 5620.4 5623.1 5917.2 6097.4 6140.5 6395.8 6428.2 6396.2 6437.7 6445.1 6627.3 6639.2 5598.4 5720.4 5759.2 5850.0 5870.3 5772.6 5813.1 5814.3 5915.8 5935.6 5113.4 5174.5 5287.9 5360.0 5515.8 5033.8 5148.3 5254.6 5290.8 5469.2 5278.7 5412.5 5421.6 5423.3 5446.9 4739.1 4749.5 4847.0 4858.1 4862.9 4804.6 4985.0 4985.9 5010.1 5012.8 02:31:07 INFO - 2015-11-15 02:31:07,936 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,937 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4072.51 Median:4730.59 stddev:1263.94 (26.7%) stddev-sans-first:1234.21 02:31:07 INFO - 2015-11-15 02:31:07,941 DEBUG : BROWSER_OUTPUT: Values: 233.9 235.6 236.4 241.6 248.3 4684.6 4707.2 4712.0 4817.4 4819.6 4460.0 4628.7 4680.3 4716.4 4720.4 3481.9 3548.8 3557.8 3561.1 3570.7 3322.8 3505.5 3515.9 3579.3 3585.2 3282.0 3425.5 3476.1 3519.2 3549.7 3402.2 3411.4 3499.3 3512.6 3533.3 2932.4 3049.4 3049.7 3058.4 3062.5 4399.2 4542.5 4569.1 4573.7 4575.2 3757.6 3931.8 3977.3 4057.3 4059.0 4751.1 4909.3 4921.7 4922.1 4923.8 3172.6 3273.9 3280.7 3285.0 3289.1 4780.6 4975.2 5023.7 5025.2 5048.3 3155.6 3265.7 3282.2 3286.9 3291.5 3256.5 3264.4 3304.0 3337.6 3344.4 3786.4 3875.3 3910.2 3919.8 3934.5 4740.5 4760.6 4901.8 4923.6 4928.4 1182.3 1190.7 1209.0 1209.0 1210.0 759.3 762.6 773.1 774.3 786.0 4579.8 4714.5 4729.9 4731.3 4737.4 5035.3 5061.8 5111.5 5161.6 5165.5 4623.0 4675.3 4700.5 4700.7 4725.5 2725.9 2774.5 2858.7 2863.3 2864.3 5109.7 5132.4 5241.4 5242.7 5253.4 5167.5 5180.6 5271.0 5280.9 5290.6 5098.5 5131.8 5227.7 5229.6 5245.4 4953.2 4980.8 5081.9 5118.4 5136.8 5107.6 5115.1 5116.3 5121.8 5122.6 4991.3 5192.4 5198.2 5285.2 5293.5 3135.4 3159.2 3203.1 3339.7 3345.4 4897.5 4987.0 5018.4 5083.7 5098.2 4910.8 4923.3 4947.4 4967.2 4968.8 4737.9 4838.8 4948.7 4949.6 4953.3 4767.8 4774.1 4912.0 4933.7 4938.2 4871.5 5009.8 5010.6 5014.7 5015.9 4772.4 4906.8 4907.7 4911.3 4946.5 02:31:07 INFO - 2015-11-15 02:31:07,941 DEBUG : BROWSER_OUTPUT: 02:31:07 INFO - 2015-11-15 02:31:07,942 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10682.98 Median:5656.52 stddev:12858.72 (227.3%) stddev-sans-first:12872.16 02:31:07 INFO - 2015-11-15 02:31:07,942 DEBUG : BROWSER_OUTPUT: Values: 523.4 563.1 592.1 608.6 619.2 10337.5 10512.4 10565.4 10831.5 10899.9 10103.4 10233.8 10270.9 10588.1 10621.7 553.5 599.8 701.7 707.9 734.3 601.5 691.6 711.1 725.9 727.0 725.2 734.9 735.3 748.2 751.0 575.2 619.4 700.7 736.3 759.0 546.5 552.1 558.1 565.2 571.5 9676.6 9842.1 9903.6 10045.1 10069.9 9091.8 9110.8 9174.5 9433.9 9824.5 7170.9 7494.7 7629.2 7759.2 7779.1 2599.7 2599.8 2606.9 2648.6 2651.7 37689.6 37810.2 37909.6 38037.0 38254.4 6887.6 7109.8 7284.9 7328.6 7357.4 15624.1 15690.7 15697.1 15733.4 15748.0 5655.5 5657.5 5730.6 5759.6 5987.3 3025.0 3060.0 3063.0 3142.0 3216.8 2312.3 2359.4 2361.2 2362.1 2363.4 332.3 341.6 341.6 370.8 385.8 390.5 404.9 423.4 458.9 462.0 5533.3 6049.1 6061.2 6109.8 6186.3 378.4 396.4 457.7 464.9 480.1 2314.3 2483.3 2615.8 2720.6 2721.5 44752.1 45763.0 45780.5 45997.3 47895.3 39504.0 40207.0 40569.8 40808.0 41064.6 36819.0 37002.6 37459.4 37843.6 38147.4 6140.4 6153.1 6321.1 6516.9 6579.9 25163.6 26300.2 26411.3 27789.3 27989.2 36145.5 36454.5 37051.4 38235.6 38273.0 6032.5 6245.9 6330.4 6399.8 6494.8 8695.4 8712.7 8736.7 8972.8 9024.9 8118.0 8171.3 8269.3 8417.1 8445.6 8296.7 8306.5 8313.7 8340.8 8443.2 8123.8 8218.8 8280.4 8297.0 8300.8 6963.8 6965.8 7076.2 7220.2 7276.4 6966.7 7061.8 7070.7 7204.1 7284.1 02:31:07 INFO - 2015-11-15 02:31:07,942 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:31:07 INFO - 2015-11-15 02:31:07,942 DEBUG : BROWSER_OUTPUT: 02:31:08 INFO - 2015-11-15 02:31:08,660 INFO : Browser exited with error code: 0 02:31:08 INFO - 2015-11-15 02:31:08,696 INFO : Completed test dromaeo_css (00:18:36) 02:31:08 INFO - 2015-11-15 02:31:08,696 INFO : Starting test kraken 02:31:08 INFO - 2015-11-15 02:31:08,696 DEBUG : operating with platform_type : mac_ 02:31:08 INFO - 2015-11-15 02:31:08,697 INFO : Initialising browser for kraken test... 02:31:08 INFO - 2015-11-15 02:31:08,713 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpDZ65iS/profile http://localhost:49666/getInfo.html 02:31:11 INFO - 2015-11-15 02:31:11,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:31:11 INFO - 2015-11-15 02:31:11,533 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:31:11 INFO - 2015-11-15 02:31:11,533 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:31:11 INFO - 2015-11-15 02:31:11,533 DEBUG : BROWSER_OUTPUT: __metrics 02:31:11 INFO - 2015-11-15 02:31:11,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:12 INFO - 2015-11-15 02:31:12,394 INFO : Browser initialized. 02:31:12 INFO - 2015-11-15 02:31:12,394 INFO : Running cycle 1/1 for kraken test... 02:31:12 INFO - 2015-11-15 02:31:12,394 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpDZ65iS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:31:24 INFO - 2015-11-15 02:31:24,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 199086080 02:31:24 INFO - 2015-11-15 02:31:24,618 DEBUG : BROWSER_OUTPUT: 02:31:27 INFO - 2015-11-15 02:31:27,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49666/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:28 INFO - 2015-11-15 02:31:28,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 265052160 02:31:28 INFO - 2015-11-15 02:31:28,399 DEBUG : BROWSER_OUTPUT: 02:31:31 INFO - 2015-11-15 02:31:31,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49666/tests/kraken/driver.html?testName=audio-dft) 02:31:32 INFO - 2015-11-15 02:31:32,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 279293952 02:31:32 INFO - 2015-11-15 02:31:32,277 DEBUG : BROWSER_OUTPUT: 02:31:35 INFO - 2015-11-15 02:31:35,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49666/tests/kraken/driver.html?testName=audio-fft) 02:31:36 INFO - 2015-11-15 02:31:36,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 262115328 02:31:36 INFO - 2015-11-15 02:31:36,388 DEBUG : BROWSER_OUTPUT: 02:31:38 INFO - 2015-11-15 02:31:38,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49666/tests/kraken/driver.html?testName=audio-oscillator) 02:31:39 INFO - 2015-11-15 02:31:39,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 262795264 02:31:39 INFO - 2015-11-15 02:31:39,438 DEBUG : BROWSER_OUTPUT: 02:31:42 INFO - 2015-11-15 02:31:42,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49666/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:31:42 INFO - 2015-11-15 02:31:42,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 263049216 02:31:42 INFO - 2015-11-15 02:31:42,705 DEBUG : BROWSER_OUTPUT: 02:31:46 INFO - 2015-11-15 02:31:46,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49666/tests/kraken/driver.html?testName=imaging-darkroom) 02:31:47 INFO - 2015-11-15 02:31:47,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 261808128 02:31:47 INFO - 2015-11-15 02:31:47,123 DEBUG : BROWSER_OUTPUT: 02:31:51 INFO - 2015-11-15 02:31:51,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49666/tests/kraken/driver.html?testName=imaging-desaturate) 02:31:51 INFO - 2015-11-15 02:31:51,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 262242304 02:31:51 INFO - 2015-11-15 02:31:51,685 DEBUG : BROWSER_OUTPUT: 02:31:55 INFO - 2015-11-15 02:31:55,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49666/tests/kraken/driver.html?testName=json-parse-financial) 02:31:55 INFO - 2015-11-15 02:31:55,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 262127616 02:31:55 INFO - 2015-11-15 02:31:55,852 DEBUG : BROWSER_OUTPUT: 02:31:57 INFO - 2015-11-15 02:31:57,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49666/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:31:58 INFO - 2015-11-15 02:31:58,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 307363840 02:31:58 INFO - 2015-11-15 02:31:58,318 DEBUG : BROWSER_OUTPUT: 02:32:00 INFO - 2015-11-15 02:32:00,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:01 INFO - 2015-11-15 02:32:01,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 305348608 02:32:01 INFO - 2015-11-15 02:32:01,111 DEBUG : BROWSER_OUTPUT: 02:32:03 INFO - 2015-11-15 02:32:03,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:32:04 INFO - 2015-11-15 02:32:04,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 302002176 02:32:04 INFO - 2015-11-15 02:32:04,265 DEBUG : BROWSER_OUTPUT: 02:32:07 INFO - 2015-11-15 02:32:07,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:08 INFO - 2015-11-15 02:32:08,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 305389568 02:32:08 INFO - 2015-11-15 02:32:08,069 DEBUG : BROWSER_OUTPUT: 02:32:11 INFO - 2015-11-15 02:32:11,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:11 INFO - 2015-11-15 02:32:11,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 301174784 02:32:11 INFO - 2015-11-15 02:32:11,868 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49666/tests/kraken/driver.html?testName=ai-astar) 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 365101056 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:32:14 INFO - 2015-11-15 02:32:14,306 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |0;ai-astar;141;141;134;140;142;150;134;147;144;135 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;197;166;211;202;171;200;171;214;201;173 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |2;audio-dft;204;207;205;204;217;217;217;219;219;206 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |3;audio-fft;98;106;97;156;90;93;95;95;158;88 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;125;128;176;113;120;125;164;118;119;164 02:32:14 INFO - 2015-11-15 02:32:14,307 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;157;156;164;164;164;164;164;163;149;156 02:32:14 INFO - 2015-11-15 02:32:14,308 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;162;160;169;169;169;170;170;167;161;161 02:32:14 INFO - 2015-11-15 02:32:14,308 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;129;137;135;136;136;136;136;137;136;134 02:32:14 INFO - 2015-11-15 02:32:14,308 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;77;81;81;80;80;80;82;80;81 02:32:14 INFO - 2015-11-15 02:32:14,308 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;79;84;84;84;84;85;86;89;90;89 02:32:14 INFO - 2015-11-15 02:32:14,309 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;110;107;107;110;112;113;118;113;126;118 02:32:14 INFO - 2015-11-15 02:32:14,309 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;160;158;168;163;162;167;172;167;165;170 02:32:14 INFO - 2015-11-15 02:32:14,309 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;178;189;192;188;197;194;201;195;196;199 02:32:14 INFO - 2015-11-15 02:32:14,309 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;87;89;94;92;89;90;95;95;94;96 02:32:14 INFO - 2015-11-15 02:32:14,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:32:14 INFO - 2015-11-15 02:32:14,310 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:32:14 INFO - 2015-11-15 02:32:14,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 02:32:14 INFO - 2015-11-15 02:32:14,310 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:32:14 INFO - 2015-11-15 02:32:14,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1447583534302__endTimestamp 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:140.80 Median:141.50 stddev:5.39 (3.8%) stddev-sans-first:5.72 02:32:14 INFO - 2015-11-15 02:32:14,311 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 134.0 140.0 142.0 150.0 134.0 147.0 144.0 135.0 02:32:14 INFO - 2015-11-15 02:32:14,312 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,312 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:190.60 Median:200.50 stddev:18.30 (9.1%) stddev-sans-first:19.26 02:32:14 INFO - 2015-11-15 02:32:14,312 DEBUG : BROWSER_OUTPUT: Values: 197.0 166.0 211.0 202.0 171.0 200.0 171.0 214.0 201.0 173.0 02:32:14 INFO - 2015-11-15 02:32:14,313 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,314 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:211.50 Median:217.00 stddev:6.74 (3.1%) stddev-sans-first:6.58 02:32:14 INFO - 2015-11-15 02:32:14,314 DEBUG : BROWSER_OUTPUT: Values: 204.0 207.0 205.0 204.0 217.0 217.0 217.0 219.0 219.0 206.0 02:32:14 INFO - 2015-11-15 02:32:14,314 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,315 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:107.60 Median:94.00 stddev:26.49 (28.2%) stddev-sans-first:27.87 02:32:14 INFO - 2015-11-15 02:32:14,315 DEBUG : BROWSER_OUTPUT: Values: 98.0 106.0 97.0 156.0 90.0 93.0 95.0 95.0 158.0 88.0 02:32:14 INFO - 2015-11-15 02:32:14,315 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,315 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:135.20 Median:126.50 stddev:23.25 (18.4%) stddev-sans-first:24.37 02:32:14 INFO - 2015-11-15 02:32:14,315 DEBUG : BROWSER_OUTPUT: Values: 125.0 128.0 176.0 113.0 120.0 125.0 164.0 118.0 119.0 164.0 02:32:14 INFO - 2015-11-15 02:32:14,316 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,316 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:160.10 Median:164.00 stddev:5.28 (3.2%) stddev-sans-first:5.48 02:32:14 INFO - 2015-11-15 02:32:14,316 DEBUG : BROWSER_OUTPUT: Values: 157.0 156.0 164.0 164.0 164.0 164.0 164.0 163.0 149.0 156.0 02:32:14 INFO - 2015-11-15 02:32:14,316 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,317 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:165.80 Median:169.00 stddev:4.24 (2.5%) stddev-sans-first:4.27 02:32:14 INFO - 2015-11-15 02:32:14,317 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 169.0 169.0 169.0 170.0 170.0 167.0 161.0 161.0 02:32:14 INFO - 2015-11-15 02:32:14,317 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,318 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:135.20 Median:136.00 stddev:2.35 (1.7%) stddev-sans-first:0.93 02:32:14 INFO - 2015-11-15 02:32:14,318 DEBUG : BROWSER_OUTPUT: Values: 129.0 137.0 135.0 136.0 136.0 136.0 136.0 137.0 136.0 134.0 02:32:14 INFO - 2015-11-15 02:32:14,318 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,318 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:79.40 Median:80.50 stddev:2.91 (3.6%) stddev-sans-first:1.39 02:32:14 INFO - 2015-11-15 02:32:14,318 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 81.0 81.0 80.0 80.0 80.0 82.0 80.0 81.0 02:32:14 INFO - 2015-11-15 02:32:14,319 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,319 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.40 Median:85.50 stddev:3.27 (3.8%) stddev-sans-first:2.52 02:32:14 INFO - 2015-11-15 02:32:14,319 DEBUG : BROWSER_OUTPUT: Values: 79.0 84.0 84.0 84.0 84.0 85.0 86.0 89.0 90.0 89.0 02:32:14 INFO - 2015-11-15 02:32:14,320 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:113.40 Median:113.00 stddev:5.85 (5.2%) stddev-sans-first:6.08 02:32:14 INFO - 2015-11-15 02:32:14,320 DEBUG : BROWSER_OUTPUT: Values: 110.0 107.0 107.0 110.0 112.0 113.0 118.0 113.0 126.0 118.0 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:165.20 Median:167.00 stddev:4.44 (2.7%) stddev-sans-first:4.29 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: Values: 160.0 158.0 168.0 163.0 162.0 167.0 172.0 167.0 165.0 170.0 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:195.50 stddev:6.64 (3.4%) stddev-sans-first:4.33 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: Values: 178.0 189.0 192.0 188.0 197.0 194.0 201.0 195.0 196.0 199.0 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:92.10 Median:94.00 stddev:3.14 (3.3%) stddev-sans-first:2.74 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: Values: 87.0 89.0 94.0 92.0 89.0 90.0 95.0 95.0 94.0 96.0 02:32:14 INFO - 2015-11-15 02:32:14,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:32:14 INFO - 2015-11-15 02:32:14,322 DEBUG : BROWSER_OUTPUT: 02:32:14 INFO - 2015-11-15 02:32:14,973 INFO : Browser exited with error code: 0 02:32:15 INFO - 2015-11-15 02:32:15,035 INFO : Completed test kraken (00:01:06) 02:32:15 INFO - 2015-11-15 02:32:15,036 INFO : Starting test v8_7 02:32:15 INFO - 2015-11-15 02:32:15,036 DEBUG : operating with platform_type : mac_ 02:32:15 INFO - 2015-11-15 02:32:15,036 INFO : Initialising browser for v8_7 test... 02:32:15 INFO - 2015-11-15 02:32:15,052 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpGLlkaK/profile http://localhost:49666/getInfo.html 02:32:17 INFO - 2015-11-15 02:32:17,779 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:32:17 INFO - 2015-11-15 02:32:17,779 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:32:17 INFO - 2015-11-15 02:32:17,779 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:32:17 INFO - 2015-11-15 02:32:17,779 DEBUG : BROWSER_OUTPUT: __metrics 02:32:17 INFO - 2015-11-15 02:32:17,795 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:18 INFO - 2015-11-15 02:32:18,679 INFO : Browser initialized. 02:32:18 INFO - 2015-11-15 02:32:18,680 INFO : Running cycle 1/1 for v8_7 test... 02:32:18 INFO - 2015-11-15 02:32:18,680 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpGLlkaK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:32:30 INFO - 2015-11-15 02:32:30,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 202866688 02:32:30 INFO - 2015-11-15 02:32:30,913 DEBUG : BROWSER_OUTPUT: 02:32:53 INFO - 2015-11-15 02:32:53,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49666/tests/v8_7/run.html (next: http://localhost:49666/tests/v8_7/run.html) 02:32:54 INFO - 2015-11-15 02:32:54,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 520966144 02:32:54 INFO - 2015-11-15 02:32:54,060 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |0;Richards;215.610176800345 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;248.5707183693761 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |2;Encrypt;412.71151465125877 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7422.222222222223 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1315.7894736842106 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |5;Earley;893.6550491510277 02:32:54 INFO - 2015-11-15 02:32:54,061 DEBUG : BROWSER_OUTPUT: |6;Boyer;16387.09677419355 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: |7;RegExp;38333.333333333336 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: |8;Splay;875.6567425569177 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7518.796992481203 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: __startTimestamp1447583574054__endTimestamp 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:215.61 Median:215.61 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: Values: 215.6 02:32:54 INFO - 2015-11-15 02:32:54,062 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:248.57 Median:248.57 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: Values: 248.6 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:412.71 Median:412.71 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: Values: 412.7 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7422.22 Median:7422.22 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: Values: 7422.2 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1315.79 Median:1315.79 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: Values: 1315.8 02:32:54 INFO - 2015-11-15 02:32:54,063 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:893.66 Median:893.66 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: Values: 893.7 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16387.10 Median:16387.10 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: Values: 16387.1 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38333.33 Median:38333.33 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: Values: 38333.3 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:875.66 Median:875.66 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: Values: 875.7 02:32:54 INFO - 2015-11-15 02:32:54,064 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,065 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7518.80 Median:7518.80 stddev:0.00 (0.0%) 02:32:54 INFO - 2015-11-15 02:32:54,065 DEBUG : BROWSER_OUTPUT: Values: 7518.8 02:32:54 INFO - 2015-11-15 02:32:54,065 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:32:54 INFO - 2015-11-15 02:32:54,065 DEBUG : BROWSER_OUTPUT: 02:32:54 INFO - 2015-11-15 02:32:54,821 INFO : Browser exited with error code: 0 02:32:54 INFO - 2015-11-15 02:32:54,847 INFO : Completed test v8_7 (00:00:39) 02:32:55 INFO - 2015-11-15 02:32:55,315 INFO : Completed test suite (00:20:23) 02:32:55 INFO - 2015-11-15 02:32:55,315 DEBUG : Working with test: dromaeo_css 02:32:55 INFO - 2015-11-15 02:32:55,315 DEBUG : Generating results file: dromaeo_css 02:32:55 INFO - 2015-11-15 02:32:55,316 DEBUG : Working with test: kraken 02:32:55 INFO - 2015-11-15 02:32:55,316 DEBUG : Generating results file: kraken 02:32:55 INFO - 2015-11-15 02:32:55,316 INFO : javascript benchmark 02:32:55 INFO - 2015-11-15 02:32:55,317 DEBUG : Working with test: v8_7 02:32:55 INFO - 2015-11-15 02:32:55,317 DEBUG : Generating results file: v8_7 02:32:55 INFO - 2015-11-15 02:32:55,317 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:32:55 INFO - 2015-11-15 02:32:55,369 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:32:55 INFO - 2015-11-15 02:32:55,369 DEBUG : process_Request line: dromaeo_css 5302.66 graph.html#tests=[[72,52,55]] 02:32:55 INFO - 2015-11-15 02:32:55,369 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:32:55 INFO - 2015-11-15 02:32:55,409 DEBUG : process_Request line: kraken 1975.20 graph.html#tests=[[232,52,55]] 02:32:55 INFO - 2015-11-15 02:32:55,409 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:32:55 INFO - 2015-11-15 02:32:55,440 DEBUG : process_Request line: v8_7 15490.57 graph.html#tests=[[230,52,55]] 02:32:55 INFO - 2015-11-15 02:32:55,441 INFO : javascript benchmark 02:32:55 INFO - 2015-11-15 02:32:55,444 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [267.0839022154011, 271.531607976241, 275.6857182811595, 279.55271565495195, 284.4055923120678, 8238.423310368276, 11135.276207046536, 13014.349282535872, 14400.639984000405, 14588.927055364722, 14754.926225368885, 14773.48292809752, 14825.777613335782, 14878.851211487881, 15166.317515711791, 4235.131797981407, 4242.512111107224, 4364.738115713068, 4417.359482874981, 4431.711938723989, 3350.8827191048317, 3351.664833516641, 3467.2198755279987, 4257.212415703089, 4585.082983403316, 4759.619230461555, 4885.364902562662, 4940.851774446773, 4941.4811444798315, 4945.381827271591, 4768.833090841838, 4779.641526885497, 4784.665073444878, 4794.161021821167, 4867.440244371889, 4231.090315582164, 4302.849400270976, 4315.82736690532, 4317.460317460317, 4319.33050377192, 17744.55638609045, 18487.0, 18527.722084168614, 18802.623947520973, 18841.811581884143, 1596.2497626115708, 1626.5039163055264, 1644.7697322374756, 1700.7363858601936, 1716.3220527891413, 10469.162467002621, 10612.575496980111, 10726.785464290671, 10770.192235582284, 11103.167262455348, 1287.485005997599, 1325.4631874090912, 1345.4685399267332, 1355.4171706166344, 1377.393946663465, 51084.48915510871, 51905.74047129778, 52014.21978670323, 52175.73912130415, 52221.21668174981, 8598.441101328393, 8633.179847914564, 8665.306775457948, 8731.126887311219, 8731.345149113715, 10969.890301096886, 10971.286866353821, 10972.561097556169, 11003.394813285346, 11006.064484518745, 6634.966825165843, 6857.382835544825, 6882.655867206619, 6955.513114082067, 7008.859822803515, 6857.451403887677, 6993.615351155633, 7044.366007059287, 7046.224915259318, 7069.434445244368, 4827.95172048275, 4916.582090522345, 4965.503449655078, 5039.269305950616, 5096.464871188546, 1301.1412467771415, 1353.35715535122, 1430.5064752660317, 1435.0743770268118, 1499.6175975126273, 332.34693826630786, 341.0926934354605, 347.92867462170193, 370.63862733834833, 377.9659830615258, 7552.962235188789, 9061.41100828444, 9421.481818499911, 9512.619495220113, 9667.516624168764, 349.135888675526, 359.55415285046877, 371.51331755399974, 380.6326894546776, 385.3410667758109, 4923.384576927884, 4931.778069986859, 4960.305557221992, 5116.130257856099, 5178.223266509978, 438994.0, 445290.0, 446637.0, 449983.0, 486348.0, 54943.725281373336, 56086.43913560894, 57341.713291433276, 57561.0, 58050.419495804505, 402.6879168644324, 411.34390646918115, 411.72208759087493, 417.16566866267465, 418.04059683027526, 8111.269985701315, 8312.5428101455, 8380.20388063133, 8475.152484751723, 8654.874866267344, 26152.8692356537, 26896.0, 27005.324866878484, 27515.58726619142, 27937.720622794324, 34730.82634586912, 36266.456003159445, 36769.816150919076, 38755.80622096871, 39067.0, 4444.622207112432, 4549.65877559191, 4801.807927682854, 4948.604111670986, 4972.353594032753, 7773.1060927994, 8755.60599772999, 8882.822343553222, 8926.86609700842, 9248.260139188715, 6701.932980670326, 7702.922970770221, 7902.802429939297, 8117.985251843519, 8133.715319963773, 7421.146568144516, 7623.618819058914, 7666.578338191453, 7861.095973963067, 8085.71699990521, 7684.1547429783795, 7853.214678532329, 7985.880211796712, 8176.305014073871, 8274.544900030556, 4764.595009424238, 4800.951990480051, 4980.32765576657, 5005.974970125126, 5041.697498150123, 7301.963490182515, 7768.223177682413, 7993.240642138988, 8035.799105022421, 8188.0], "dojo.html": [2481.1564068216803, 2498.350428888489, 2507.7492250774926, 2547.7707006369446, 2552.0302285131647, 4205.810738516767, 4256.297710877705, 4292.527821939584, 4317.15815415994, 4317.222899878021, 4221.915561688765, 4224.831006759726, 4285.078708077763, 4292.742435453867, 4312.159128969852, 3754.530683664542, 3754.8685795997144, 3844.2503711776217, 3901.648851603355, 3968.841246350157, 3765.585785563586, 3864.7487913285686, 3915.549711783153, 3934.763914165145, 4009.3384591542363, 3950.6641935435523, 3956.960430395688, 3989.5611482736876, 4040.9797951010205, 4062.2890994076065, 3952.822123004472, 3954.4859168307935, 3980.024893901013, 3991.680665546764, 4066.0648050948153, 3564.6613571710645, 3760.4735337052834, 3777.508923839883, 3865.768053916774, 3879.049632839944, 4061.1471590965934, 4081.1225586499045, 4196.496420429568, 4210.642095421893, 4215.45199124115, 4434.334849772527, 4449.777511124431, 4500.842470513517, 4554.3851580036935, 4557.817687292504, 4287.078278170208, 4493.056458143794, 4564.246899261618, 4620.468646105707, 4621.098885717286, 4111.8972025699295, 4228.429162063144, 4256.5105012923605, 4402.3176407656865, 4411.338299255138, 4601.769911504478, 4636.86089417318, 4681.7425041622355, 4689.296605509201, 4730.645201609893, 4293.74237545742, 4326.891827704332, 4408.845690400821, 4499.77501124949, 4534.614557762628, 4442.577955094261, 4537.523560026216, 4575.016371480147, 4605.263157894721, 4657.417822772153, 4506.1663592235545, 4567.223571992769, 4613.469451013109, 4616.330632058332, 4676.953230467651, 4257.084726783756, 4336.241157797373, 4588.6099681526775, 4651.511591282867, 4706.270528068155, 3454.4300190468293, 3546.858125674996, 3547.3260080584605, 3566.928661426809, 3595.478655594924, 3143.732782713449, 3182.44307246231, 3213.4376484115187, 3225.7903236289567, 3272.0511051794715, 4071.9796401017807, 4092.9181416371507, 4157.958420415757, 4218.135282267128, 4271.487421509377, 4194.412782210493, 4425.557444255549, 4435.844745433894, 4487.371767952489, 4738.763061846894, 4140.834366625361, 4160.479940007499, 4211.494620645542, 4295.291276939332, 4325.1565944641125, 3971.185906889081, 3996.320625493673, 4133.731307465006, 4136.834526618902, 4141.213169497786, 4496.258117410591, 4505.48186958504, 4568.908621827479, 4597.954020459752, 4742.193827049341, 4388.561143885586, 4501.819927202875, 4547.840825571221, 4579.221532339577, 4629.652776041878, 4503.572160644733, 4540.841070562515, 4551.977240113778, 4685.156671798973, 4694.6244300456565, 4316.395704601421, 4355.673324500612, 4424.889377765453, 4481.686281960362, 4495.2358099122575, 4522.4573051234065, 4550.590446859798, 4618.376519169869, 4638.489766125656, 4686.671932964659, 4418.867433976986, 4450.955490445054, 4529.048899731093, 4570.565796249351, 4597.93103103447, 4089.1412803311637, 4257.74453532789, 4324.005478739845, 4386.934195986999, 4452.042810795694, 4326.2212801696, 4335.0, 4389.802458889421, 4443.044745379759, 4474.351219073281, 4407.823687052611, 4457.375967364636, 4502.099580083931, 4524.02733412318, 4571.885702857455, 4275.529691733845, 4281.828726850891, 4315.007548263854, 4352.042550638855, 4360.062586543908], "mootools.html": [545.9699716515595, 1171.9355435451052, 1331.0216990511972, 1339.1496399786135, 1474.9041312314691, 5443.4828691274315, 5609.186667933152, 5676.858078548038, 5956.5234781217505, 5958.851028724284, 5848.853778655525, 5889.587728858982, 5928.962431574479, 6082.756689732405, 6096.146539484475, 1683.0, 1686.1990554486642, 1691.4671878358308, 1713.1348668922176, 1715.4682048564923, 1678.6474840283556, 1716.6824137534534, 1724.34474899538, 1729.161356741979, 1766.222861940742, 1733.679269335177, 1765.8234176582303, 1778.786545614528, 1782.162383679675, 1788.2757483219316, 1720.664470428267, 1727.8876873003278, 1742.0157610949773, 1771.8139595342432, 1779.17268470162, 1713.76864123343, 1745.9912700436544, 1780.5904641932427, 1782.8128046555184, 1786.7855857297207, 5394.136938089926, 6013.969930150365, 6040.335563088057, 6049.425304596057, 6064.727087281083, 3124.562561241428, 3328.400887840188, 3641.435577485494, 3642.05306620278, 3726.869559565402, 2200.6038912995655, 2211.2813335665974, 2286.7255929288426, 2290.0496294037953, 2291.942701432461, 564.7797359029981, 659.7361055577759, 668.5954997226705, 669.7388018672722, 702.0942983551213, 7812.296893279632, 7862.8427431451055, 7891.723789667334, 7895.092064412609, 7899.289063984269, 3404.7786893852317, 3468.4623883297622, 3469.462233353834, 3534.0, 3563.8396272167815, 6927.238003819576, 6929.5842249465195, 6932.168139823153, 6932.480063995221, 6936.514443988974, 3748.700103991674, 3810.3903375459795, 3830.636089571486, 3846.0384903774057, 3846.480725102131, 3496.300739851989, 3497.4753786931656, 3502.124468882779, 3503.5445392098864, 3506.6142724300307, 2878.1221727372936, 2909.3744844858456, 2919.080489645755, 2959.363736796599, 2960.0231923465203, 928.9489078100769, 939.0281059103795, 952.1335584618103, 959.6017652674202, 964.8359778837614, 817.6770175780533, 836.8493671139254, 867.2238346679812, 872.9825403491894, 883.1257055514994, 5528.281323427928, 5705.087186050212, 5745.88508229833, 5768.394318596571, 5775.133729940542, 368.0871438831712, 375.4312216991206, 380.16743332102607, 382.273680007987, 388.970827187962, 4316.223079845595, 4330.826766929351, 4470.977645111819, 4576.977115114403, 4584.587387135107, 7002.474814388839, 7038.049863268496, 7083.5041547091205, 7171.103612048494, 7174.748883789147, 6869.484788640772, 6914.481413893978, 7045.859082818315, 7090.397316228075, 7192.496525243183, 4939.481354457802, 5143.717095559706, 5314.335708036496, 5647.209390685307, 5648.0, 5058.974705126451, 5346.572274218131, 5379.112446446449, 5620.437956204347, 5623.128415095667, 5917.230760001173, 6097.390260973867, 6140.478059364826, 6395.808125756234, 6428.19647544057, 6396.200474940632, 6437.7103030362805, 6445.065465507381, 6627.271000190071, 6639.236487803964, 5598.412166722435, 5720.399358067343, 5759.193712880284, 5849.970750146393, 5870.26621672291, 5772.5959182856795, 5813.128030795415, 5814.331351894417, 5915.822525324247, 5935.584509084322, 5113.386393632639, 5174.534291913746, 5287.947120528899, 5359.973200133974, 5515.834524964257, 5033.84898453047, 5148.279240906351, 5254.579633629377, 5290.81482148123, 5469.206964989975, 5278.656887302313, 5412.485813847678, 5421.647592906448, 5423.29497165366, 5446.891062178814, 4739.075880203465, 4749.477557468606, 4846.975765121152, 4858.076965376567, 4862.90274194507, 4804.567588917014, 4985.0, 4985.875353116201, 5010.148274793367, 5012.8496145115705], "ext.html": [438.91002344519376, 442.41601086565737, 444.82207117153143, 452.0, 470.77638121892085, 25549.616755748655, 27199.0, 31456.842715786388, 31943.520847187312, 32447.188820279447, 33813.154671133234, 34690.65309346906, 35215.82392088036, 35290.294194116104, 35340.46989295162, 6683.465322774191, 7245.5290406123695, 7317.890231646529, 7352.411807055422, 7429.8483735021155, 6691.36432038958, 6811.761588344409, 8580.313574913991, 8833.779155521099, 8888.333374996868, 8405.453645513022, 8462.23839854413, 8797.472151670889, 8805.339599530029, 8824.02935677075, 6930.27232140623, 7073.787786366417, 8539.444936079166, 8655.567221638892, 8671.69649062283, 6556.442702370305, 8488.575571221476, 8808.03111657717, 8815.20663140314, 8843.513606751627, 31571.21071973196, 31938.520922186184, 32230.83884580562, 32624.836875815705, 32672.346553068804, 2385.3440303916386, 2423.6970378702663, 2464.322311364371, 2626.2121363591036, 2735.6990731019573, 22065.0, 22276.55446891053, 22412.55174896493, 22700.091996320127, 23568.175113871104, 1702.8722845786492, 1741.8954862708151, 1749.1953701297418, 1769.78762548495, 1798.7751531058618, 231666.0, 232697.0, 232824.0, 233964.0, 235481.0, 44065.339019914725, 45164.54835451669, 45730.0, 50558.0, 51047.7447612767, 52794.47205527972, 53619.0, 53934.0, 54013.459865400844, 54079.45920540823, 13631.863681363258, 13874.93062534681, 13875.930620346833, 13879.514217002357, 13890.097143685629, 10406.947965260126, 10418.68743937683, 10595.470226488798, 10596.89403105959, 10700.839487407695, 16213.756793648105, 16341.673166536602, 16558.420455284006, 16846.157692115346, 16933.238004289837, 6810.684367315137, 6858.5199036068, 6968.3728464438445, 6998.970298613447, 7038.612876291751, 710.0804458226609, 719.8848184290489, 729.6643543969833, 830.9529992209859, 849.6888463379597, 21917.67123493117, 22697.0, 22767.544649106923, 22974.65538016931, 23063.308100757004, 751.0311697909744, 846.7502086884384, 850.8128211793396, 923.316745608245, 984.625842179967, 8994.955025224832, 11676.154395925765, 11847.763044739057, 11856.407179640983, 12055.0, 341423.0, 352236.0, 352873.0, 353338.0, 356461.0, 39450.80274598609, 43870.34194487085, 44509.77745111254, 44665.0, 45260.3210951836, 1050.495762034228, 1133.6032388664066, 1140.5209811878865, 1146.6846617180342, 1147.581132886507, 20738.792612073685, 21825.672614910472, 23005.88497057504, 23099.0, 23149.537009259384, 38235.61764382321, 38973.805130974164, 39710.404343934286, 40376.79811600923, 40993.385099224135, 157188.0, 159150.0, 159824.0, 161502.0, 162284.0, 24088.0, 24244.63633045541, 24533.754662453146, 24969.87515062413, 25335.6199657009, 33201.83399082989, 33417.33165336631, 34438.655613443545, 34820.82589587036, 35623.28753424865, 29075.273118172216, 29330.120096397142, 29354.853225733736, 29619.555706664847, 29907.401851962404, 23581.0, 23674.0, 23737.762622374245, 23738.169164079176, 23805.285841424786, 28900.855495722386, 29566.556501652063, 29759.0, 29803.254918627208, 29855.850720747127, 24809.62785558254, 25382.873085634452, 25721.5275937746, 25761.0, 25822.741772582034, 19075.90462047681, 19235.0, 19521.902390487958, 19721.40835774929, 19914.60170796605], "prototype.html": [233.87838324071484, 235.57008459561294, 236.41605235069383, 241.62548050521687, 248.33941715038003, 4684.6252299816015, 4707.1762441572755, 4711.976440117799, 4817.397825271841, 4819.638527110467, 4460.0, 4628.745419001953, 4680.25115981443, 4716.434027916646, 4720.409948756405, 3481.860725570974, 3548.840302186395, 3557.839897204619, 3561.145325121965, 3570.7143428525787, 3322.7840190387546, 3505.526753888231, 3515.876944306937, 3579.284143171363, 3585.1754096557806, 3281.96718032819, 3425.5375524304272, 3476.1135910342828, 3519.1905861651835, 3549.6805287524116, 3402.166469215058, 3411.3688967541084, 3499.335126326003, 3512.5784905811465, 3533.2580158166943, 2932.428176505582, 3049.40536595364, 3049.6797836227097, 3058.4341896749174, 3062.525308577174, 4399.208142534342, 4542.454905411339, 4569.13186494565, 4573.656975726801, 4575.176468235716, 3757.5866654667966, 3931.783751893645, 3977.3238549446664, 4057.2899742544937, 4059.0, 4751.073540659539, 4909.3126962225315, 4921.729304888229, 4922.114019476493, 4923.75381230937, 3172.6034245719284, 3273.9017829465156, 3280.6883346082086, 3285.0309158798214, 3289.079057863778, 4780.593649539794, 4975.154223781966, 5023.673461225045, 5025.195968644999, 5048.268001139851, 3155.5739975103065, 3265.6571060038355, 3282.2450836307785, 3286.917827054343, 3291.489819078047, 3256.5115232715284, 3264.396086723964, 3304.041827869939, 3337.632860385356, 3344.414727422691, 3786.4320351947426, 3875.3024455597697, 3910.1788624389196, 3919.784411857318, 3934.5278566572197, 4740.478547359788, 4760.64295177863, 4901.754912254373, 4923.556879880828, 4928.383952005999, 1182.3319824299244, 1190.678516800459, 1208.9818652720217, 1209.0448545649015, 1210.0259291270436, 759.3090287838041, 762.5805806806235, 773.0954782904016, 774.2760518914832, 786.0449553792056, 4579.839705610288, 4714.504976977437, 4729.881752956135, 4731.2903064539905, 4737.360456338351, 5035.269885866529, 5061.822836200715, 5111.488851114858, 5161.612879034013, 5165.535101840853, 4623.006053698471, 4675.275332323496, 4700.482946875841, 4700.7179569225955, 4725.480197178307, 2725.8909643614033, 2774.4867199568143, 2858.6712528059124, 2863.3414314707734, 2864.255293623673, 5109.6678715883345, 5132.384113906355, 5241.42344342122, 5242.7378631068295, 5253.4221235664045, 5167.4832516748775, 5180.559652429511, 5271.0, 5280.9471905281225, 5290.576753859682, 5098.5411312982005, 5131.794728210904, 5227.712475813791, 5229.607779416559, 5245.3705555332845, 4953.1676377314525, 4980.825671101494, 5081.92377114351, 5118.43697193301, 5136.768845401891, 5107.591392688651, 5115.053715062725, 5116.258142569232, 5121.820736274212, 5122.564582010571, 4991.301217829579, 5192.42883282831, 5198.194279886624, 5285.154375299933, 5293.470652934676, 3135.3729254148807, 3159.241781972264, 3203.0550987459224, 3339.682730140633, 3345.448001079892, 4897.4857639947295, 4987.027529631687, 5018.447970723145, 5083.669561478492, 5098.1842905135, 4910.8281210157475, 4923.286123512143, 4947.431045429822, 4967.155583550732, 4968.751562421792, 4737.9052418952115, 4838.758062096811, 4948.703077815343, 4949.604031677529, 4953.257011448168, 4767.809287628595, 4774.069056533943, 4911.9754401227765, 4933.703977761345, 4938.160512712776, 4871.48849370811, 5009.824656137163, 5010.649254552146, 5014.749262536931, 5015.949840501694, 4772.355731976278, 4906.803727850989, 4907.656464047625, 4911.3369695090705, 4946.530079642428], "yui.html": [523.382408757666, 563.0540691638048, 592.0762768501146, 608.6439432931735, 619.1764952613025, 10337.483125843706, 10512.421816800073, 10565.366078035324, 10831.458427078644, 10899.891001089996, 10103.444310562934, 10233.846492302602, 10270.897291027088, 10588.100011499013, 10621.681349559525, 553.4520824383851, 599.7900734742849, 701.7438634898276, 707.8867381219006, 734.2620666230457, 601.527800676469, 691.5781373362245, 711.0933559711383, 725.9128904531464, 726.9709211631555, 725.1805459830384, 734.8897665350213, 735.334522257358, 748.2405358561065, 751.0461713623695, 575.1832397994857, 619.3589634728035, 700.7092056796423, 736.3483317264206, 758.9696412143535, 546.4999525434223, 552.1000768746917, 558.1460365640577, 565.2482198675751, 571.4885177765918, 9676.56455459506, 9842.065003824626, 9903.60385584583, 10045.14616257619, 10069.949650251776, 9091.81816363669, 9110.77223069422, 9174.541272936392, 9433.858492122623, 9824.508774561315, 7170.928290717078, 7494.6627401767055, 7629.19893411195, 7759.203980099503, 7779.105402878628, 2599.6750406199226, 2599.8440093594445, 2606.8696565171854, 2648.576227803542, 2651.7480839320233, 37689.623103768885, 37810.24379512422, 37909.620903790885, 38037.0, 38254.42618360727, 6887.621180835002, 7109.786706398816, 7284.854302913912, 7328.633568321563, 7357.41140708742, 15624.062556246661, 15690.68618627621, 15697.136657483949, 15733.44932927365, 15748.0, 5655.519280861091, 5657.51911087554, 5730.598858079978, 5759.568032397503, 5987.2815262168815, 3024.9546256806166, 3059.98470007653, 3063.0, 3142.0, 3216.758743094277, 2312.329424466886, 2359.351178425912, 2361.2207971369407, 2362.055177928842, 2363.3618922890723, 332.2739813507494, 341.5900918897333, 341.6481024544723, 370.75900664567706, 385.77046657238895, 390.4689622113923, 404.90484736086995, 423.38397631446173, 458.8574449620421, 462.00824873096474, 5533.3083364579425, 6049.141790486088, 6061.212042434456, 6109.8472538186015, 6186.288576813634, 378.42857285499093, 396.4469564956869, 457.732226647415, 464.87913142582494, 480.0998128509045, 2314.2941402872284, 2483.255023492945, 2615.803814713904, 2720.6327145835453, 2721.4693134838913, 44752.10495790131, 45763.0, 45780.542194578295, 45997.310040349425, 47895.28157077647, 39504.0, 40207.0, 40569.797151014056, 40808.0, 41064.589354106676, 36819.0, 37002.62997369992, 37459.43810842894, 37843.62156378401, 38147.42778858319, 6140.355262697352, 6153.138560601609, 6321.11504389395, 6516.869662606816, 6579.868402632016, 25163.622545662194, 26300.21099367022, 26411.339716507242, 27789.305267368476, 27989.160325190278, 36145.45781813222, 36454.453183201746, 37051.44422833714, 38235.61764382321, 38273.04317392087, 6032.4570788629235, 6245.875082498415, 6330.3669633036325, 6399.816034033719, 6494.837629059311, 8695.434796738191, 8712.738617841474, 8736.650533978569, 8972.820543588961, 9024.86462703073, 8118.037332277024, 8171.346292296721, 8269.338452923632, 8417.116202798617, 8445.619947102272, 8296.668133274601, 8306.54314012735, 8313.6674533018, 8340.833183336421, 8443.24010839003, 8123.79690507742, 8218.753437396888, 8280.420370574244, 8297.0, 8300.750977470685, 6963.79108626742, 6965.79102626922, 7076.22161562238, 7220.241874603091, 7276.381507571916, 6966.721331146698, 7061.788146355618, 7070.71717131309, 7204.063471748848, 7284.125904891447]}, "summary": {"suite": 5302.656949700228, "subtests": {"jquery.html": {"filtered": 6149.7590456458065, "value": 6149.7590456458065}, "dojo.html": {"filtered": 4189.375076364919, "value": 4189.375076364919}, "mootools.html": {"filtered": 3349.5234057104985, "value": 3349.5234057104985}, "ext.html": {"filtered": 14917.549818521273, "value": 14917.549818521273}, "prototype.html": {"filtered": 3651.380168884004, "value": 3651.380168884004}, "yui.html": {"filtered": 4728.940733002528, "value": 4728.940733002528}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447582351, "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": "20151115004211", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}, {"talos_counters": {}, "results": {"audio-dft": [204.0, 207.0, 205.0, 204.0, 217.0, 217.0, 217.0, 219.0, 219.0, 206.0], "ai-astar": [141.0, 141.0, 134.0, 140.0, 142.0, 150.0, 134.0, 147.0, 144.0, 135.0], "imaging-gaussian-blur": [157.0, 156.0, 164.0, 164.0, 164.0, 164.0, 164.0, 163.0, 149.0, 156.0], "audio-beat-detection": [197.0, 166.0, 211.0, 202.0, 171.0, 200.0, 171.0, 214.0, 201.0, 173.0], "json-stringify-tinderbox": [79.0, 84.0, 84.0, 84.0, 84.0, 85.0, 86.0, 89.0, 90.0, 89.0], "stanford-crypto-pbkdf2": [178.0, 189.0, 192.0, 188.0, 197.0, 194.0, 201.0, 195.0, 196.0, 199.0], "json-parse-financial": [72.0, 77.0, 81.0, 81.0, 80.0, 80.0, 80.0, 82.0, 80.0, 81.0], "stanford-crypto-sha256-iterative": [87.0, 89.0, 94.0, 92.0, 89.0, 90.0, 95.0, 95.0, 94.0, 96.0], "audio-fft": [98.0, 106.0, 97.0, 156.0, 90.0, 93.0, 95.0, 95.0, 158.0, 88.0], "imaging-darkroom": [162.0, 160.0, 169.0, 169.0, 169.0, 170.0, 170.0, 167.0, 161.0, 161.0], "stanford-crypto-ccm": [160.0, 158.0, 168.0, 163.0, 162.0, 167.0, 172.0, 167.0, 165.0, 170.0], "audio-oscillator": [125.0, 128.0, 176.0, 113.0, 120.0, 125.0, 164.0, 118.0, 119.0, 164.0], "stanford-crypto-aes": [110.0, 107.0, 107.0, 110.0, 112.0, 113.0, 118.0, 113.0, 126.0, 118.0], "imaging-desaturate": [129.0, 137.0, 135.0, 136.0, 136.0, 136.0, 136.0, 137.0, 136.0, 134.0]}, "summary": {"suite": 1975.2000000000005, "subtests": {"audio-fft": {"filtered": 107.6, "value": 107.6}, "stanford-crypto-pbkdf2": {"filtered": 192.9, "value": 192.9}, "audio-beat-detection": {"filtered": 190.6, "value": 190.6}, "stanford-crypto-ccm": {"filtered": 165.2, "value": 165.2}, "imaging-darkroom": {"filtered": 165.8, "value": 165.8}, "json-parse-financial": {"filtered": 79.4, "value": 79.4}, "audio-oscillator": {"filtered": 135.2, "value": 135.2}, "ai-astar": {"filtered": 140.8, "value": 140.8}, "audio-dft": {"filtered": 211.5, "value": 211.5}, "stanford-crypto-sha256-iterative": {"filtered": 92.1, "value": 92.1}, "json-stringify-tinderbox": {"filtered": 85.4, "value": 85.4}, "imaging-gaussian-blur": {"filtered": 160.1, "value": 160.1}, "stanford-crypto-aes": {"filtered": 113.4, "value": 113.4}, "imaging-desaturate": {"filtered": 135.2, "value": 135.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447582351, "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": "20151115004211", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}, {"talos_counters": {}, "results": {"DeltaBlue": [248.5707183693761], "Encrypt": [412.71151465125877], "NavierStokes": [7518.796992481203], "Decrypt": [7422.222222222223], "Splay": [875.6567425569177], "Richards": [215.610176800345], "RegExp": [38333.333333333336], "Earley": [893.6550491510277], "Boyer": [16387.09677419355], "RayTrace": [1315.7894736842106]}, "summary": {"suite": 15490.568417694612, "subtests": {"DeltaBlue": {"filtered": 265.99271400000003, "value": 265.99271400000003}, "Encrypt": {"filtered": 644.9565630000003, "value": 644.9565630000003}, "NavierStokes": {"filtered": 197.37199999999996, "value": 197.37199999999996}, "Decrypt": {"filtered": 35.86270958083829, "value": 35.86270958083829}, "Splay": {"filtered": 93.06272199999998, "value": 93.06272199999998}, "RegExp": {"filtered": 23.76482608695654, "value": 23.76482608695654}, "Richards": {"filtered": 163.73067600000005, "value": 163.73067600000005}, "Earley": {"filtered": 745.772097, "value": 745.772097}, "Boyer": {"filtered": 40.66998622047241, "value": 40.66998622047241}, "RayTrace": {"filtered": 562.3916399999999, "value": 562.3916399999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447582351, "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": "20151115004211", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}] 02:32:55 INFO - RETURN: dromaeo_css: 5302.66 02:32:55 INFO - RETURN: kraken: 1975.20 02:32:55 INFO - RETURN: v8_7: 15490.57 02:32:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "15490.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1975.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5302.66"}}} 02:32:55 INFO - Return code: 0 02:32:55 INFO - # TBPL SUCCESS # 02:32:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:32:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:32:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:32:55 INFO - 2015-11-15 02:32:55.578 screenresolution[2007:25232] starting screenresolution argv=screenresolution get 02:32:55 INFO - 2015-11-15 02:32:55.581 screenresolution[2007:25232] Display 0: 1600x1200x32@60 02:32:55 INFO - 2015-11-15 02:32:55.589 screenresolution[2008:25235] starting screenresolution argv=screenresolution list 02:32:55 INFO - Available Modes on Display 0 02:32:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:32:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:32:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:32:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:32:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:32:55 INFO - Intel HD Graphics 3000: 02:32:55 INFO - Chipset Model: Intel HD Graphics 3000 02:32:55 INFO - Type: GPU 02:32:55 INFO - Bus: Built-In 02:32:55 INFO - VRAM (Total): 512 MB 02:32:55 INFO - VRAM (Dynamic, Max): 10 02:32:55 INFO - Vendor: Intel (0x8086) 02:32:55 INFO - Device ID: 0x0116 02:32:55 INFO - Revision ID: 0x0009 02:32:55 INFO - Displays: 02:32:55 INFO - Display: 02:32:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:32:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:32:55 INFO - Display Serial Number: 1600x1200 60 02:32:55 INFO - Main Display: Yes 02:32:55 INFO - Mirror: Off 02:32:55 INFO - Online: Yes 02:32:55 INFO - Rotation: Supported 02:32:55 INFO - Return code: 0 02:32:55 INFO - Running post-action listener: _resource_record_post_action 02:32:55 INFO - Running post-run listener: _resource_record_post_run 02:32:56 INFO - Total resource usage - Wall time: 1271s; CPU: 30.0%; Read bytes: 253952; Write bytes: 686277632; Read time: 85; Write time: 66675 02:32:56 INFO - install - Wall time: 46s; CPU: 30.0%; Read bytes: 340890112; Write bytes: 342636544; Read time: 41147; Write time: 6968 02:32:57 INFO - run-tests - Wall time: 1225s; CPU: 30.0%; Read bytes: 208896; Write bytes: 341908480; Read time: 58; Write time: 59691 02:32:57 INFO - Running post-run listener: _upload_blobber_files 02:32:57 INFO - Blob upload gear active. 02:32:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:32:57 INFO - Copying logs to upload dir... 02:32:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1334.721594 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-15 02:32:57.078919) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:32:57.082068) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012195 build_url: 'https://queue.taskcluster.net/v1/task/6DYzn2usQQOLo_vlHRfd4g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:32:57.112687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:32:57.113020) ========= 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.DjIDt8jxFr/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.zZU4anuvKv/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.006298 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 02:32:57.163469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 02:32:57.163945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 02:32:57.164332) ========= ========= Total master_lag: 0.30 =========