builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0017 starttime: 1445476269.77 results: success (0) buildid: 20151021162101 builduid: a7773f73c5d74332ab2574084c10e07d revision: f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:09.768594) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:09.769020) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:09.769339) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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.005864 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:10.088095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-10-21 18:11:10.088422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-10-21 18:11:11.301567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:11.302238) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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.026437 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:11.606274) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:11.606845) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:11.607513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:11.608003) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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-10-21 18:11:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-10-21 18:11:12 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.366895 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:12.118902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:12.119266) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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.061827 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:12.423073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-21 18:11:12.423508) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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-10-21 18:11:12,574 truncating revision to first 12 chars 2015-10-21 18:11:12,574 Setting DEBUG logging. 2015-10-21 18:11:12,574 attempt 1/10 2015-10-21 18:11:12,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f029ccdee154?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-21 18:11:14,845 unpacking tar archive at: mozilla-central-f029ccdee154/testing/mozharness/ program finished with exit code 0 elapsedTime=3.416368 ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-10-21 18:11:16.389156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:16.389494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:16.985864) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:16.986309) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 18:11:16.986845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-10-21 18:11:16.987177) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:11:17 INFO - MultiFileLogger online at 20151021 18:11:17 in /builds/slave/test 18:11:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:11:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:17 INFO - {'append_to_log': False, 18:11:17 INFO - 'base_work_dir': '/builds/slave/test', 18:11:17 INFO - 'blob_upload_branch': 'Firefox', 18:11:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:17 INFO - 'branch': 'Firefox', 18:11:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:17 INFO - 'config_files': ('talos/mac_config.py',), 18:11:17 INFO - 'default_actions': ('clobber', 18:11:17 INFO - 'read-buildbot-config', 18:11:17 INFO - 'download-and-extract', 18:11:17 INFO - 'populate-webroot', 18:11:17 INFO - 'create-virtualenv', 18:11:17 INFO - 'install', 18:11:17 INFO - 'run-tests'), 18:11:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:17 INFO - 'download_minidump_stackwalk': True, 18:11:17 INFO - 'download_symbols': 'ondemand', 18:11:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:17 INFO - 'installer_path': 'installer.exe', 18:11:17 INFO - 'log_level': 'info', 18:11:17 INFO - 'log_name': 'talos', 18:11:17 INFO - 'log_to_console': True, 18:11:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:17 INFO - 'opt_config_files': (), 18:11:17 INFO - 'pip_index': False, 18:11:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:17 INFO - 'cmd': ('bash', 18:11:17 INFO - '-c', 18:11:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:17 INFO - 'enabled': True, 18:11:17 INFO - 'halt_on_failure': False, 18:11:17 INFO - 'name': 'check_screen_resolution'},), 18:11:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:17 INFO - 'cmd': ('bash', 18:11:17 INFO - '-c', 18:11:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:17 INFO - 'enabled': True, 18:11:17 INFO - 'halt_on_failure': False, 18:11:17 INFO - 'name': 'check_screen_resolution'},), 18:11:17 INFO - 'run_cmd_checks_enabled': True, 18:11:17 INFO - 'sps_profile': False, 18:11:17 INFO - 'sps_profile_interval': 0, 18:11:17 INFO - 'suite': 'dromaeojs', 18:11:17 INFO - 'system_bits': '64', 18:11:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:17 INFO - 'title': 't-yosemite-r5-0017', 18:11:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:17 INFO - 'use_talos_json': True, 18:11:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:17 INFO - 'work_dir': 'build'} 18:11:17 INFO - ##### 18:11:17 INFO - ##### Running clobber step. 18:11:17 INFO - ##### 18:11:17 INFO - Running pre-action listener: _resource_record_pre_action 18:11:17 INFO - Running main action method: clobber 18:11:17 INFO - rmtree: /builds/slave/test/build 18:11:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:20 INFO - Running post-action listener: _resource_record_post_action 18:11:20 INFO - ##### 18:11:20 INFO - ##### Running read-buildbot-config step. 18:11:20 INFO - ##### 18:11:20 INFO - Running pre-action listener: _resource_record_pre_action 18:11:20 INFO - Running main action method: read_buildbot_config 18:11:20 INFO - Using buildbot properties: 18:11:20 INFO - { 18:11:20 INFO - "properties": { 18:11:20 INFO - "buildnumber": 527, 18:11:20 INFO - "product": "firefox", 18:11:20 INFO - "script_repo_revision": "production", 18:11:20 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 18:11:20 INFO - "repository": "", 18:11:20 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 18:11:20 INFO - "buildid": "20151021162101", 18:11:20 INFO - "slavename": "t-yosemite-r5-0017", 18:11:20 INFO - "pgo_build": "False", 18:11:20 INFO - "basedir": "/builds/slave/test", 18:11:20 INFO - "project": "", 18:11:20 INFO - "platform": "yosemite", 18:11:20 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:11:20 INFO - "slavebuilddir": "test", 18:11:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:11:20 INFO - "branch": "mozilla-central", 18:11:20 INFO - "repo_path": "mozilla-central", 18:11:20 INFO - "stage_platform": "macosx64", 18:11:20 INFO - "builduid": "a7773f73c5d74332ab2574084c10e07d", 18:11:20 INFO - "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b" 18:11:20 INFO - }, 18:11:20 INFO - "sourcestamp": { 18:11:20 INFO - "repository": "", 18:11:20 INFO - "hasPatch": false, 18:11:20 INFO - "project": "", 18:11:20 INFO - "branch": "mozilla-central-macosx64-talos", 18:11:20 INFO - "changes": [ 18:11:20 INFO - { 18:11:20 INFO - "category": null, 18:11:20 INFO - "files": [ 18:11:20 INFO - { 18:11:20 INFO - "url": null, 18:11:20 INFO - "name": "https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg" 18:11:20 INFO - } 18:11:20 INFO - ], 18:11:20 INFO - "repository": "", 18:11:20 INFO - "rev": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b", 18:11:20 INFO - "who": "kwierso@gmail.com", 18:11:20 INFO - "when": 1445476183, 18:11:20 INFO - "number": 6556576, 18:11:20 INFO - "comments": "Bug 1203159 - Tweak environment test for appdir change. r=gfritzsche\n\nSome DevTools files are changing how they are installed. This environment test\nrelies on add-on manager infrastructure, which also loads some DevTools files.\n\nTo access these DevTools files in XPCShell from a Firefox build, we need to set\n`firefox-appdir = browser` in the test manifest. However, this then causes\n`GMPProvider` to become enabled where it was not before, changing the values of\nthe test.\n\nThe test is adjusted to reflect the values `GMPProvider` reports.\n", 18:11:20 INFO - "project": "", 18:11:20 INFO - "at": "Wed 21 Oct 2015 18:09:43", 18:11:20 INFO - "branch": "mozilla-central-macosx64-talos", 18:11:20 INFO - "revlink": "", 18:11:20 INFO - "properties": [ 18:11:20 INFO - [ 18:11:20 INFO - "buildid", 18:11:20 INFO - "20151021162101", 18:11:20 INFO - "Change" 18:11:20 INFO - ], 18:11:20 INFO - [ 18:11:20 INFO - "builduid", 18:11:20 INFO - "a7773f73c5d74332ab2574084c10e07d", 18:11:20 INFO - "Change" 18:11:20 INFO - ], 18:11:20 INFO - [ 18:11:20 INFO - "pgo_build", 18:11:20 INFO - "False", 18:11:20 INFO - "Change" 18:11:20 INFO - ] 18:11:20 INFO - ], 18:11:20 INFO - "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b" 18:11:20 INFO - } 18:11:20 INFO - ], 18:11:20 INFO - "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b" 18:11:20 INFO - } 18:11:20 INFO - } 18:11:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg. 18:11:20 INFO - Running post-action listener: _resource_record_post_action 18:11:20 INFO - ##### 18:11:20 INFO - ##### Running download-and-extract step. 18:11:20 INFO - ##### 18:11:20 INFO - Running pre-action listener: _resource_record_pre_action 18:11:20 INFO - Running main action method: download_and_extract 18:11:20 INFO - mkdir: /builds/slave/test/build/tests 18:11:20 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')]} 18:11:20 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/test_packages.json 18:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/test_packages.json 18:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:11:23 INFO - Downloaded 1149 bytes. 18:11:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:11:23 INFO - Using the following test package requirements: 18:11:23 INFO - {u'common': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 18:11:23 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.cppunittest.tests.zip'], 18:11:23 INFO - u'jittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'jsshell-mac.zip'], 18:11:23 INFO - u'mochitest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.mochitest.tests.zip'], 18:11:23 INFO - u'mozbase': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 18:11:23 INFO - u'reftest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.reftest.tests.zip'], 18:11:23 INFO - u'talos': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.talos.tests.zip'], 18:11:23 INFO - u'web-platform': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.web-platform.tests.zip'], 18:11:23 INFO - u'webapprt': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 18:11:23 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 18:11:23 INFO - u'firefox-44.0a1.en-US.mac.xpcshell.tests.zip']} 18:11:23 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:11:23 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')]} 18:11:23 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:11:36 INFO - Downloaded 17440206 bytes. 18:11:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:11:40 INFO - Return code: 0 18:11:40 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip', u'firefox-44.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:11:40 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')]} 18:11:40 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:11:49 INFO - Downloaded 17440206 bytes. 18:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 18:11:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:11:54 INFO - Return code: 0 18:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:54 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 18:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 18:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 18:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:12:01 INFO - Downloaded 11128529 bytes. 18:12:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 18:12:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 18:12:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:12:02 INFO - Return code: 0 18:12: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')]} 18:12:02 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 18:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 18:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg 18:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg'}, attempt #1 18:12:05 INFO - Downloaded 111438292 bytes. 18:12:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 18:12:05 INFO - mkdir: /builds/slave/test/properties 18:12:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:05 INFO - Contents: 18:12:05 INFO - build_url:https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 18:12:05 INFO - Running post-action listener: _resource_record_post_action 18:12:05 INFO - Running post-action listener: set_extra_try_arguments 18:12:05 INFO - ##### 18:12:05 INFO - ##### Running populate-webroot step. 18:12:05 INFO - ##### 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: populate_webroot 18:12:05 INFO - Guessing talos json url... 18:12:05 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')]} 18:12:05 INFO - https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt matches https://queue.taskcluster.net 18:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 18:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 18:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 18:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.txt'}, attempt #1 18:12:07 INFO - Downloaded 99 bytes. 18:12:07 INFO - Reading from file /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 18:12:07 INFO - Contents: 18:12:07 INFO - 20151021162101 18:12:07 INFO - https://hg.mozilla.org/mozilla-central/rev/f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b 18:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:07 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/f029ccdee1/testing/talos/talos.json 18:12:07 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/f029ccdee1/testing/talos/talos.json to /builds/slave/test/build/talos.json 18:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/f029ccdee1/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 18:12:08 INFO - Downloaded 4264 bytes. 18:12:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:12:08 INFO - '../fennec_ids.txt'], 18:12:08 INFO - 'tests': ['tcheck2']}, 18:12:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:08 INFO - '--tppagecycles', 18:12:08 INFO - '7'], 18:12:08 INFO - 'tests': ['tsvgm']}}, 18:12:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:12:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:12:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:12:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'tests': ['damp', 'tps']}, 18:12:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['damp', 'tps']}, 18:12:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:12:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:08 INFO - 'other': {'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'other_l64': {'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'other_nol64': {'tests': ['a11yr', 18:12:08 INFO - 'ts_paint', 18:12:08 INFO - 'tpaint', 18:12:08 INFO - 'sessionrestore', 18:12:08 INFO - 'sessionrestore_no_auto_restore']}, 18:12:08 INFO - 'svgr': {'tests': ['tsvgx', 18:12:08 INFO - 'tsvgr_opacity', 18:12:08 INFO - 'tart', 18:12:08 INFO - 'tscrollx', 18:12:08 INFO - 'cart']}, 18:12:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['tsvgx', 18:12:08 INFO - 'tsvgr_opacity', 18:12:08 INFO - 'tart', 18:12:08 INFO - 'tscrollx', 18:12:08 INFO - 'cart']}, 18:12:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'tests': ['tp5o']}, 18:12:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'talos_options': ['--e10s'], 18:12:08 INFO - 'tests': ['tp5o']}, 18:12:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'talos_options': ['--xperf_path', 18:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:08 INFO - 'tests': ['tp5n']}, 18:12:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:08 INFO - 'talos_options': ['--e10s', 18:12:08 INFO - '--xperf_path', 18:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 18:12:08 INFO - 'C:/slave/talos-data/talos/xperf.config'], 18:12:08 INFO - 'tests': ['tp5n']}}, 18:12:08 INFO - 'talos.zip': {'path': '', 18:12:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:08 INFO - Running post-action listener: _resource_record_post_action 18:12:08 INFO - ##### 18:12:08 INFO - ##### Running create-virtualenv step. 18:12:08 INFO - ##### 18:12:08 INFO - Running pre-action listener: _resource_record_pre_action 18:12:08 INFO - Running main action method: create_virtualenv 18:12:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:08 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 18:12:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:08 INFO - Using real prefix '/tools/python27' 18:12:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:13 INFO - Installing pip.................done. 18:12:13 INFO - Return code: 0 18:12:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:13 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 18:12:13 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 18:12:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:13 INFO - 'HOME': '/Users/cltbld', 18:12:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:13 INFO - 'LOGNAME': 'cltbld', 18:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:13 INFO - 'MOZ_NO_REMOTE': '1', 18:12:13 INFO - 'NO_EM_RESTART': '1', 18:12:13 INFO - 'PAGER': '/bin/cat', 18:12:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:13 INFO - 'PWD': '/builds/slave/test', 18:12:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:13 INFO - 'SHELL': '/bin/bash', 18:12:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:13 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:13 INFO - 'USER': 'cltbld', 18:12:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:13 INFO - 'XPC_FLAGS': '0x0', 18:12:13 INFO - 'XPC_SERVICE_NAME': '0', 18:12:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:13 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 18:12:13 INFO - Cleaning up... 18:12:13 INFO - Return code: 0 18:12:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:13 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 18:12:13 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 18:12:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:13 INFO - 'HOME': '/Users/cltbld', 18:12:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:13 INFO - 'LOGNAME': 'cltbld', 18:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:13 INFO - 'MOZ_NO_REMOTE': '1', 18:12:13 INFO - 'NO_EM_RESTART': '1', 18:12:13 INFO - 'PAGER': '/bin/cat', 18:12:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:13 INFO - 'PWD': '/builds/slave/test', 18:12:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:13 INFO - 'SHELL': '/bin/bash', 18:12:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:13 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:13 INFO - 'USER': 'cltbld', 18:12:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:13 INFO - 'XPC_FLAGS': '0x0', 18:12:13 INFO - 'XPC_SERVICE_NAME': '0', 18:12:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:14 INFO - Downloading/unpacking psutil>=0.7.1 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:12:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:19 INFO - Installing collected packages: psutil 18:12:19 INFO - Running setup.py install for psutil 18:12:19 INFO - building 'psutil._psutil_osx' extension 18:12:19 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:22 INFO - building 'psutil._psutil_posix' extension 18:12:22 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 18:12:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:12:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:12:22 INFO - ^ 18:12:22 INFO - 1 warning generated. 18:12:22 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 18:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:22 INFO - Successfully installed psutil 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:12:22 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')]} 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:22 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')]} 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:22 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:22 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 18:12:22 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 18:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:22 INFO - 'HOME': '/Users/cltbld', 18:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:22 INFO - 'LOGNAME': 'cltbld', 18:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:22 INFO - 'MOZ_NO_REMOTE': '1', 18:12:22 INFO - 'NO_EM_RESTART': '1', 18:12:22 INFO - 'PAGER': '/bin/cat', 18:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:22 INFO - 'PWD': '/builds/slave/test', 18:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:22 INFO - 'SHELL': '/bin/bash', 18:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:22 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:22 INFO - 'USER': 'cltbld', 18:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:22 INFO - 'XPC_FLAGS': '0x0', 18:12:22 INFO - 'XPC_SERVICE_NAME': '0', 18:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:12:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:12:27 INFO - Installing collected packages: mozsystemmonitor 18:12:27 INFO - Running setup.py install for mozsystemmonitor 18:12:27 INFO - Successfully installed mozsystemmonitor 18:12:27 INFO - Cleaning up... 18:12:27 INFO - Return code: 0 18:12:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:27 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')]} 18:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:27 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')]} 18:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:27 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:27 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 18:12:27 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 18:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:27 INFO - 'HOME': '/Users/cltbld', 18:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:27 INFO - 'LOGNAME': 'cltbld', 18:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:27 INFO - 'MOZ_NO_REMOTE': '1', 18:12:27 INFO - 'NO_EM_RESTART': '1', 18:12:27 INFO - 'PAGER': '/bin/cat', 18:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:27 INFO - 'PWD': '/builds/slave/test', 18:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:27 INFO - 'SHELL': '/bin/bash', 18:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:27 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:27 INFO - 'USER': 'cltbld', 18:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:27 INFO - 'XPC_FLAGS': '0x0', 18:12:27 INFO - 'XPC_SERVICE_NAME': '0', 18:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:27 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:27 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 18:12:27 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 18:12:27 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 18:12:27 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 18:12:27 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 18:12:27 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 18:12:29 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:32 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 18:12:32 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 18:12:32 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 18:12:32 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 18:12:32 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 18:12:32 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 18:12:32 INFO - Downloading docopt-0.6.1.tar.gz 18:12:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:32 INFO - Running setup.py install for blobuploader 18:12:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:32 INFO - Running setup.py install for requests 18:12:33 INFO - Running setup.py install for docopt 18:12:33 INFO - Successfully installed blobuploader requests docopt 18:12:33 INFO - Cleaning up... 18:12:33 INFO - Return code: 0 18:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:33 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:33 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 18:12:33 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 18:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:33 INFO - 'HOME': '/Users/cltbld', 18:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:33 INFO - 'LOGNAME': 'cltbld', 18:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:33 INFO - 'MOZ_NO_REMOTE': '1', 18:12:33 INFO - 'NO_EM_RESTART': '1', 18:12:33 INFO - 'PAGER': '/bin/cat', 18:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:33 INFO - 'PWD': '/builds/slave/test', 18:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:33 INFO - 'SHELL': '/bin/bash', 18:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:33 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:33 INFO - 'USER': 'cltbld', 18:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:33 INFO - 'XPC_FLAGS': '0x0', 18:12:33 INFO - 'XPC_SERVICE_NAME': '0', 18:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-ThKnFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-A7fW91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-SkNLgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-59olVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-y78KaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-FC8l6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-c3v3hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:34 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-NQlUNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-fa3dmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Tl4Gnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-zgBX9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-AHIbRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-kC79_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-CM9MwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:35 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-9oqjqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:36 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-8JLLpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:36 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-bZLYrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:36 INFO - Running setup.py install for manifestparser 18:12:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:36 INFO - Running setup.py install for mozcrash 18:12:36 INFO - Running setup.py install for mozdebug 18:12:36 INFO - Running setup.py install for mozdevice 18:12:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Running setup.py install for mozfile 18:12:37 INFO - Running setup.py install for mozhttpd 18:12:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Running setup.py install for mozinfo 18:12:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Running setup.py install for mozInstall 18:12:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:37 INFO - Running setup.py install for mozleak 18:12:37 INFO - Running setup.py install for mozlog 18:12:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Running setup.py install for moznetwork 18:12:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Running setup.py install for mozprocess 18:12:38 INFO - Running setup.py install for mozprofile 18:12:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Running setup.py install for mozrunner 18:12:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:38 INFO - Running setup.py install for mozscreenshot 18:12:39 INFO - Running setup.py install for moztest 18:12:39 INFO - Running setup.py install for mozversion 18:12:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:39 INFO - Cleaning up... 18:12:39 INFO - Return code: 0 18:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:39 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')]} 18:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:39 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')]} 18:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:39 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:39 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 18:12:39 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 18:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:39 INFO - 'HOME': '/Users/cltbld', 18:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:39 INFO - 'LOGNAME': 'cltbld', 18:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:39 INFO - 'MOZ_NO_REMOTE': '1', 18:12:39 INFO - 'NO_EM_RESTART': '1', 18:12:39 INFO - 'PAGER': '/bin/cat', 18:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:39 INFO - 'PWD': '/builds/slave/test', 18:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:39 INFO - 'SHELL': '/bin/bash', 18:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:39 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:39 INFO - 'USER': 'cltbld', 18:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:39 INFO - 'XPC_FLAGS': '0x0', 18:12:39 INFO - 'XPC_SERVICE_NAME': '0', 18:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:39 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Sf9z6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:39 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)) 18:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:39 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-XprHcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:39 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)) 18:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:39 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Ircz0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Kfg0w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-kEPoP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-tzalLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-1YCT6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-NEbh9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-_DS1aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:40 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)) 18:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:40 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-2ZCKRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-CpIf7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-eU93Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-qU5j8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-HQfD43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-jHArXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Bviqsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:41 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)) 18:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:41 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-mnWye_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:41 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)) 18:12:41 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)) 18:12:41 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)) 18:12:41 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)) 18:12:41 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)) 18:12:41 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)) 18:12:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:41 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 18:12:41 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 18:12:41 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 18:12:41 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 18:12:41 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 18:12:41 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 18:12:44 INFO - Downloading blessings-1.5.1.tar.gz 18:12:44 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 18:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:44 INFO - Installing collected packages: blessings 18:12:44 INFO - Running setup.py install for blessings 18:12:44 INFO - Successfully installed blessings 18:12:44 INFO - Cleaning up... 18:12:45 INFO - Return code: 0 18:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:45 INFO - Reading from file tmpfile_stdout 18:12:45 INFO - Current package versions: 18:12:45 INFO - blessings == 1.5.1 18:12:45 INFO - blobuploader == 1.2.4 18:12:45 INFO - docopt == 0.6.1 18:12:45 INFO - manifestparser == 1.1 18:12:45 INFO - mozInstall == 1.12 18:12:45 INFO - mozcrash == 0.16 18:12:45 INFO - mozdebug == 0.1 18:12:45 INFO - mozdevice == 0.46 18:12:45 INFO - mozfile == 1.2 18:12:45 INFO - mozhttpd == 0.7 18:12:45 INFO - mozinfo == 0.8 18:12:45 INFO - mozleak == 0.1 18:12:45 INFO - mozlog == 3.0 18:12:45 INFO - moznetwork == 0.27 18:12:45 INFO - mozprocess == 0.22 18:12:45 INFO - mozprofile == 0.27 18:12:45 INFO - mozrunner == 6.10 18:12:45 INFO - mozscreenshot == 0.1 18:12:45 INFO - mozsystemmonitor == 0.0 18:12:45 INFO - moztest == 0.7 18:12:45 INFO - mozversion == 1.4 18:12:45 INFO - psutil == 3.1.1 18:12:45 INFO - requests == 1.2.3 18:12:45 INFO - wsgiref == 0.1.2 18:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:45 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 0x108d9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e08228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f3706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, '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.4N5xESgqQd/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.fD2CwApoFr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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 18:12:45 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 18:12:45 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 18:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:45 INFO - 'HOME': '/Users/cltbld', 18:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:45 INFO - 'LOGNAME': 'cltbld', 18:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:45 INFO - 'MOZ_NO_REMOTE': '1', 18:12:45 INFO - 'NO_EM_RESTART': '1', 18:12:45 INFO - 'PAGER': '/bin/cat', 18:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:45 INFO - 'PWD': '/builds/slave/test', 18:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:45 INFO - 'SHELL': '/bin/bash', 18:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:12:45 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:45 INFO - 'USER': 'cltbld', 18:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:45 INFO - 'XPC_FLAGS': '0x0', 18:12:45 INFO - 'XPC_SERVICE_NAME': '0', 18:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 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)) 18:12:45 INFO - Cleaning up... 18:12:45 INFO - Return code: 0 18:12:45 INFO - Running post-action listener: _resource_record_post_action 18:12:45 INFO - Running post-action listener: _start_resource_monitoring 18:12:45 INFO - Starting resource monitoring. 18:12:45 INFO - ##### 18:12:45 INFO - ##### Running install step. 18:12:45 INFO - ##### 18:12:45 INFO - Running pre-action listener: _resource_record_pre_action 18:12:45 INFO - Running main action method: install 18:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:46 INFO - Reading from file tmpfile_stdout 18:12:46 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:46 INFO - Reading from file tmpfile_stdout 18:12:46 INFO - Output received: 18:12:46 INFO - Usage: mozinstall [options] installer 18:12:46 INFO - Options: 18:12:46 INFO - -h, --help show this help message and exit 18:12:46 INFO - -d DEST, --destination=DEST 18:12:46 INFO - Directory to install application into. [default: 18:12:46 INFO - "/builds/slave/test"] 18:12:46 INFO - --app=APP Application being installed. [default: firefox] 18:12:46 INFO - mkdir: /builds/slave/test/build/application 18:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:13:25 INFO - Reading from file tmpfile_stdout 18:13:25 INFO - Output received: 18:13:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:13:25 INFO - Running post-action listener: _resource_record_post_action 18:13:25 INFO - ##### 18:13:25 INFO - ##### Running run-tests step. 18:13:25 INFO - ##### 18:13:25 INFO - Running pre-action listener: _resource_record_pre_action 18:13:25 INFO - Running main action method: run_tests 18:13:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:13:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:13:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:13:25 INFO - 2015-10-21 18:13:25.934 screenresolution[1626:7552] starting screenresolution argv=screenresolution get 18:13:25 INFO - 2015-10-21 18:13:25.937 screenresolution[1626:7552] Display 0: 1600x1200x32@60 18:13:25 INFO - 2015-10-21 18:13:25.944 screenresolution[1627:7554] starting screenresolution argv=screenresolution list 18:13:25 INFO - Available Modes on Display 0 18:13:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:13:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:13:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:13:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:13:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:13:26 INFO - Intel HD Graphics 3000: 18:13:26 INFO - Chipset Model: Intel HD Graphics 3000 18:13:26 INFO - Type: GPU 18:13:26 INFO - Bus: Built-In 18:13:26 INFO - VRAM (Total): 512 MB 18:13:26 INFO - VRAM (Dynamic, Max): 10 18:13:26 INFO - Vendor: Intel (0x8086) 18:13:26 INFO - Device ID: 0x0116 18:13:26 INFO - Revision ID: 0x0009 18:13:26 INFO - Displays: 18:13:26 INFO - Display: 18:13:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:13:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:13:26 INFO - Display Serial Number: 1600x1200 60 18:13:26 INFO - Main Display: Yes 18:13:26 INFO - Mirror: Off 18:13:26 INFO - Online: Yes 18:13:26 INFO - Rotation: Supported 18:13:26 INFO - Return code: 0 18:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:13:26 INFO - Python 2.7.3 18:13:26 INFO - Return code: 0 18:13:26 INFO - grabbing minidump binary from tooltool 18:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:26 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 0x108d509f0>, '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 0x108aafcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d1a990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:13:26 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 18:13:26 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 18:13:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:13:26 INFO - Return code: 0 18:13:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0017', '--webServer', 'localhost'] in /builds/slave/test/build 18:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0017 --webServer localhost 18:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4N5xESgqQd/Render', 18:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:26 INFO - 'HOME': '/Users/cltbld', 18:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:26 INFO - 'LOGNAME': 'cltbld', 18:13:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:13:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:26 INFO - 'MOZ_NO_REMOTE': '1', 18:13:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:13:26 INFO - 'NO_EM_RESTART': '1', 18:13:26 INFO - 'PAGER': '/bin/cat', 18:13:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:26 INFO - 'PWD': '/builds/slave/test', 18:13:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:26 INFO - 'SHELL': '/bin/bash', 18:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fD2CwApoFr/Listeners', 18:13:26 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 18:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:26 INFO - 'USER': 'cltbld', 18:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:26 INFO - 'XPC_FLAGS': '0x0', 18:13:26 INFO - 'XPC_SERVICE_NAME': '0', 18:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:13:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0017', '--webServer', 'localhost'] with output_timeout 3600 18:13:26 INFO - mozversion INFO | application_buildid: 20151021162101 18:13:26 INFO - mozversion INFO | application_changeset: f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b 18:13:26 INFO - mozversion INFO | application_display_name: Nightly 18:13:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:13:26 INFO - mozversion INFO | application_name: Firefox 18:13:26 INFO - mozversion INFO | application_remotingname: firefox 18:13:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:13:26 INFO - mozversion INFO | application_vendor: Mozilla 18:13:26 INFO - mozversion INFO | application_version: 44.0a1 18:13:26 INFO - mozversion INFO | platform_buildid: 20151021162101 18:13:26 INFO - mozversion INFO | platform_changeset: f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b 18:13:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:13:26 INFO - mozversion INFO | platform_version: 44.0a1 18:13:26 INFO - 2015-10-21 18:13:26,661 DEBUG : using testdate: 1445476406 18:13:26 INFO - 2015-10-21 18:13:26,661 DEBUG : actual date: 1445476406 18:13:26 INFO - 2015-10-21 18:13:26,678 INFO : starting webserver on 'localhost:49271' 18:13:26 INFO - 2015-10-21 18:13:26,679 INFO : Starting test suite t-yosemite-r5-0017 18:13:26 INFO - 2015-10-21 18:13:26,680 INFO : Starting test dromaeo_css 18:13:26 INFO - 2015-10-21 18:13:26,680 DEBUG : operating with platform_type : mac_ 18:13:26 INFO - 2015-10-21 18:13:26,681 INFO : Initialising browser for dromaeo_css test... 18:13:26 INFO - 2015-10-21 18:13:26,695 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpKvgPc0/profile http://localhost:49271/getInfo.html 18:13:29 INFO - 2015-10-21 18:13:29,869 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:13:29 INFO - 2015-10-21 18:13:29,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:13:29 INFO - 2015-10-21 18:13:29,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:13:29 INFO - 2015-10-21 18:13:29,870 DEBUG : BROWSER_OUTPUT: __metrics 18:13:29 INFO - 2015-10-21 18:13:29,886 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:13:30 INFO - 2015-10-21 18:13:30,647 INFO : Browser initialized. 18:13:30 INFO - 2015-10-21 18:13:30,648 INFO : Running cycle 1/1 for dromaeo_css test... 18:13:30 INFO - 2015-10-21 18:13:30,648 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpKvgPc0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:13:42 INFO - 2015-10-21 18:13:42,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 222609408 18:13:42 INFO - 2015-10-21 18:13:42,658 DEBUG : BROWSER_OUTPUT: 18:14:33 INFO - 2015-10-21 18:14:33,680 DEBUG : BROWSER_OUTPUT: 1445476473676 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] 18:16:45 INFO - 2015-10-21 18:16:45,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 18:16:46 INFO - 2015-10-21 18:16:46,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 352751616 18:16:46 INFO - 2015-10-21 18:16:46,692 DEBUG : BROWSER_OUTPUT: 18:19:49 INFO - 2015-10-21 18:19:49,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 18:19:50 INFO - 2015-10-21 18:19:50,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 359858176 18:19:50 INFO - 2015-10-21 18:19:50,059 DEBUG : BROWSER_OUTPUT: 18:22:52 INFO - 2015-10-21 18:22:52,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 18:22:52 INFO - 2015-10-21 18:22:52,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 354127872 18:22:52 INFO - 2015-10-21 18:22:52,816 DEBUG : BROWSER_OUTPUT: 18:25:54 INFO - 2015-10-21 18:25:54,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 18:25:55 INFO - 2015-10-21 18:25:55,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 348184576 18:25:55 INFO - 2015-10-21 18:25:55,453 DEBUG : BROWSER_OUTPUT: 18:28:58 INFO - 2015-10-21 18:28:58,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 18:28:59 INFO - 2015-10-21 18:28:59,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 313823232 18:28:59 INFO - 2015-10-21 18:28:59,388 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 18:32:02 INFO - 2015-10-21 18:32:02,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 380694528 18:32:02 INFO - 2015-10-21 18:32:02,573 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,573 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:32:02 INFO - 2015-10-21 18:32:02,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:32:02 INFO - 2015-10-21 18:32:02,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:32:02 INFO - 2015-10-21 18:32:02,574 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:32:02 INFO - 2015-10-21 18:32:02,574 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2967.3175169710953;2994.850257487125;3008.1426793363867;3034.150437877394;3132.5301204819275;4862.489438608948;5093.9235911461265;5229.581633469323;5237.8952420951555;5240.109181439155;5101.464346243647;5132.769025393857;5137.17805151175;5215.660982036165;5244.187150991593;4672.2057250267535;4687.578117969382;4694.882627934295;4700.976495117537;4742.857714268577;4740.454847692507;4755.072760811626;4789.688670236424;4800.183968725325;4838.854834354957;4613.446386433616;4724.692894961817;4729.905401891977;4730.574248317634;4736.786844592001;4650.906981860344;4681.368015317923;4684.227102528079;4688.624910007191;4777.689450185727;4557.202489564346;4670.626349892001;4681;4681.7190968542;4697.154512187805;5043.167877300241;5067.949320506821;5071.518205770446;5098.745062746885;5101.489851014906;5285.245315441044;5295.391030031557;5306.3632364116165;5313.521783039545;5376;5235.607329450307;5405.37838148614;5413.296271484682;5418.106012507931;5445.83662490126;4967.875803104951;4993.101241776515;5060.924086138748;5101.234814777776;5119.744012799345;5473.507384335429;5504.532114770209;5529.972350138223;5548.805791797348;5622;5084.593232541388;5272.630915835932;5284.894302113936;5292.708901010405;5361.437049109865;5281.603879709037;5360.678359298455;5375.784968601212;5387.138057910715;5437.728113594384;5322.228276899906;5376.7042812644895;5390.326209223847;5396.055690254189;5397;5169.043726910533;5389.9191512127345;5395.839894422639;5436.6194366393975;5490.670559766427;4071.3078776607454;4155.439015732837;4164.604362585549;4181.832726690898;4188.727732697365;3703.222323312081;3707.6848467879995;3719.1445967427103;3719.5350581177354;3784.6215378462484;4969.552740253394;4971.825986090469;4985.152524070917;5000.099982003201;5050.419201791768;5182.378114626194;5348.197770334481;5355.758990845421;5370.060239458079;5471.890562188734;5004.699718016931;5025.045241404122;5028.547430731252;5032.345795046621;5043.36957880265;4752.833650822274;4754.500777418321;4756.54812792791;4806.759662016885;4825.5898248649255;5344.225087362311;5435.972820135874;5498.752556134984;5502.972485137549;5563.499285064364;5499.312585926759;5504.256925315031;5532.170174473861;5536.335639723259;5597.160425936142;5532.889342213214;5569.693666848362;5581.832545023656;5603.0474819281635;5630.859228519156;5031.7735701894235;5168.173092305213;5183.792648294177;5257.4742525747115;5306.097963346318;5240.947590524199;5339.359276886798;5439.5920305978;5460.726963651881;5508.504234618904;5301.814436494704;5329.786808527616;5354.009508240988;5354.839354819362;5391.05656510117;5040.319556859924;5143.382794064736;5172.922406163986;5184.844454666366;5281.313429254173;5095.235714642833;5122.769475373542;5134.589232861437;5163.302954101298;5208.192730126836;5258.553022993088;5292.629515933848;5304.310439642822;5326.467353264643;5356.866078348073;4978.5270399312;5066.746662666926;5088.084144853814;5109.565686916654;5186.662866913639 18:32:02 INFO - 2015-10-21 18:32:02,574 DEBUG : BROWSER_OUTPUT: |1;ext.html;467.87367410799084;470.87757183132385;474.23647926837805;475.9262314341278;508.7278306106234;28038;29104.126876193695;35205;35212.99999999997;35817.64182358182;37598.4360234596;38333;38473.230535389346;38540.302178847494;38582;7563.092428908539;8322.459040162385;8442.197991190827;8523.403361764678;8531.530765807878;7480.102387713482;9960.452175130366;10265.281430299845;10279.948600256988;10316.742081447948;10022.699319020441;10119.595216191343;10141.949290253538;10142.594296228142;10172.38965662059;7663.540187588706;7866.0560732711865;9863.802723945517;9969.900300997042;10075.596976120947;9833.508324583814;9966.850497242474;10007.849882251772;10008.749781255454;10056.094951454332;36131.63868361335;36405.45391819125;36551.26897462036;36583;36607.63392366096;2762.1713485954333;2862.2844288927768;2947.263184203949;3233.5634689316876;3306.206510437502;24477;24535.87732061346;24684.629730554057;25156.11953581616;25639.871800640878;1891.7635295588052;1906.551960289331;1924.3745782620565;1929.700237371967;1961.7351657526194;254424;255916;256871;256941;258225;51086.23370649443;51164;51358.48641513612;51449;51484.74257628763;51701;53709.46290537123;53820.73089634527;55406.72296638491;56288.71855640696;13862.584122476343;13964.511242106477;14189.290535473185;14192.503262385973;14263.144211347353;10442.425666588411;10541.683749487527;10551.419671918118;10566.207534434949;10602.575896964036;16031.19844007795;16108.919455402647;16111.194440277939;16115.677686446206;16148.677026459405;7708.49894756839;8020.879686804703;8029.678812847537;8052.919470805217;8065.879011814827;827.8758186272107;875.7416562114191;932.0353434195575;947.9478628675489;961.3462845265286;25539.36151596188;25828.225153245432;25958.87020564923;27138.45723085527;27910.16269511918;908.4276905549593;932.8507438809894;964.7458304204506;972.4408465132577;1005.4470041477158;12838.614841554769;12841.614751557468;13093.345332733325;13152.342382881008;13258.73482530344;280796;284821;286978;287730;287768;46832.7658361706;47159.05681886343;47206.76396618064;47247.76376118166;47444.288335674995;1204.8012078007207;1220.560598184653;1239.9566015189425;1244.807054906491;1253.5424570031691;24257.895630801315;24682.382940425916;24821.887146896428;24851;24882.502349952538;42098;42484.362734559625;42531.7873410631;42671.1465770689;42748.78625606852;266592;267479;267694;268617;269483;23598.88200558986;24203.878980604983;26711.599326010513;29153.271168220115;29754.107376777865;36125;36210.82735035906;36280.274394511434;36386.81806591056;36680.81659591685;29953;30286.242843928198;30867.228319292197;30918.381632366778;31195;24367.80689737932;26938;30043.849780751832;30504.08487745371;31020.379592408477;29188.854055729586;29420.11739647814;29469.705302946695;29503.704962950094;29635.110946671633;26036.739632603432;27541.586876197274;28168.29579260535;29521.557176642797;29826.70173298326;21381.868351595193;21408;21683.674744878525;21818;21909.671354930008 18:32:02 INFO - 2015-10-21 18:32:02,578 DEBUG : BROWSER_OUTPUT: |2;jquery.html;302.8122564010313;311.34928000478993;313.4436375433605;324.59587813172595;325.6232865188;12961;12981.545645902395;15398;15617.438256174377;15915.920420397897;10524;10849.023587877089;10875.401852898107;14333.78499322511;16089.83910160898;4021.8391264349466;4140.565240649734;4149.7095203335775;4159.480064991876;4163.20899029185;3134.529820526928;3228.047725920859;3928.7249892507534;4112.198121366335;4345.826166953334;4370.934435983447;4374.825006999717;4409.757463339515;4415.602595766381;4430.579094985971;4263.4031235627035;4386.561343865604;4387.034852332514;4387.210302145612;4391.692581519295;3662.7619204751873;3683.28176005679;3687.6128006559193;3692.9076773080888;3694.1872787986867;11732.120090993125;11954.521819127225;11991.28052316855;12018;12114.878851211462;1649.8102718187442;1658.8009438867293;1693.7882764654419;1731.0306228512075;1755.4382597568783;8595.871061934076;8625.870611940825;8747.475151490868;8842.5136617486;8990.820183596357;1368.7673095573775;1401.6636007358263;1405.2973513243378;1413.7596608576464;1448.4423496953748;52818.73590632061;55711.72144139294;56108.71945640286;56228.437715623135;57197.71401143009;5640.7743690252755;5692.7722891083895;5720.141978703145;5763.971180144073;5789.2763404574425;6547.279799222082;6591.143151390289;6623.801285961429;6641.269460359356;6648.769977554168;4765.7140571565815;4841.12859685253;4864.78108485119;4880.8779780505065;4885.780139893714;5148.124818780816;5156.5616922562;5172.612054095958;5190;5233.267342572043;2597.8701064946677;2616.5290247755206;2621.357767347012;2639.4853003664102;2640.155150351907;933.3793027636546;935.5743136872707;945.938513996588;949.0319873728758;980.181548407088;344.10303314958196;345.0511094490152;384.4003354766573;398.7308566717454;400.11774038245596;9677.854832177523;10106.292559520763;10247;10302.02130797573;10377.688669339932;354.7782635852592;380.1920918049146;407.25748656890346;434.3549828504668;440.69812178657725;5379.78480860769;5540.889182216333;5583.246261754611;5601.271834661468;5616.129499927518;339179;344736;345032;346446;512312;61407.69296153491;62965.68517157385;63228.683856581345;65000.67499662566;65065.67467162634;431.439129132127;442.4248476979913;444.6887178974666;447.19728088081973;447.2084410593297;9334.25325973907;9336.813263734552;9427.764305892408;9691.176250018827;10017.39895606266;30242.092737217037;31768.682313177498;31800.36399272048;32783.34433311368;32990;43996;44074.77962610166;44209;44620.33069504025;45127.32309015302;6631.933680663132;6872.69072891711;6986.091808064919;6996.05553250325;7019.19279282889;10519.526621302213;10527.368357898551;10672.946635266773;10690.358578485315;10765.569377224823;8856.734297971072;9078.09219078087;9125.954370228106;9150.176484116195;9165.679201227926;8110.553919534483;8160.714374996846;8576.228139467477;8690.174433429067;8879.511626860585;9116.817663646558;9122.543872806466;9144.908550914406;9395.765105872408;9435.29235307341;6709.094272273181;6871;6896.034555162381;6896.7586134485055;6907.447404207551;8277.337812975067;8460.788480288042;9077.636894524145;9089.454632722058;9186.954065229898 18:32:02 INFO - 2015-10-21 18:32:02,579 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1231.9815202771954;1299.4542292237263;1433.7849322601608;1440.7550716378214;1691.6447546015336;7882.093559240689;8273.338132949364;8657.870131948026;8831.381803273773;8859.069797671233;8329.208725171115;8439.662413503467;8467;8491.702790402322;8498.660053597863;2137.4976880433087;2170;2182.2689399051255;2184.006277143904;2191.5069109450405;2211.292386436341;2226.9331920042346;2288.828337874658;2297.942551436219;2304.539092181562;2195.3523710505438;2204.7574766775642;2221.7222847144108;2229.520653059592;2231.6317807561813;2134.4877229464973;2143.303426386423;2153.687715281283;2161.3948094533557;2163.7403511578555;2205.106931692667;2217.323716266538;2224.1103558576538;2224.1881713174735;2225.9332220033425;7725.884111738328;8313.709020184264;8351.749447516584;8398.580070996486;8466.365022623266;4482.686211965164;4982.103221420143;5116.334876466073;5124.615653825978;5137.255098010804;2905.8692358843905;2922.517784565544;2981.105668299523;2985.5521671749193;3029.242689327668;849.3460035772421;854.8760429737653;886.1271647427279;894.5303715549323;1352.9797053044213;12408.193467424588;12499.875001249962;12511.249325040435;12544.24734515932;12697.238165709994;4373.343998400265;4452.931296488884;4517.841875534341;4533.523979982055;4535.070310586322;9701.6604418845;9709.465979371062;9711.854322185172;9713.514324283757;9728.951355243178;5094.923576146361;5110.974445127825;5111.182210846321;5118.129917913963;5144.202648589475;4647.09381670571;4653.488116307203;4655.441347038377;4661.580457758818;4674.5325467452985;3367.7305815534696;3468.21965057865;3468.705160061423;3468.843902024415;3490.336836001152;1013.5591017907234;1031.7008067660295;1043.0664555223184;1044.587387981743;1047.3663433622548;1195.748892732536;1221.2062159596155;1257.0258050011314;1257.063487701668;1274.7195616964252;8100.83798324042;8308.792280193044;8341.290990265774;8362.8327433451;8380.16198380157;447.20174488537805;454.63856234293814;467.3503829676752;467.38538821449686;469.25388632075163;5609.102543593006;5682.034054210794;5685.374608793029;5716.79991200306;5937.584369094208;9826.361286516354;10699.197560183018;10877.238593298393;10879.020888120107;10890.564377424815;10506.369617822955;10642.25504214713;10708.89291107079;10850.457477126112;10861.945690271497;8039.557824319601;8103.837923241502;8129;8129.918700813035;8169.101398846122;7909.485883417559;8115.878261826196;8146.470479418819;8192.918070819454;8212.384071194565;8962.193402593797;9226.538673066454;9249.491277979776;9324.207442367204;9391;9202.493862837608;9484.099010593982;9669.226461883172;9710.70867873965;9717.028297170227;7512.737054203077;7618.352440042437;7634.847303054019;7679.731209407644;7750.263724946121;8423.199796019613;8433.87349189775;8437.114103019094;8455.32357411418;8456.915430845613;7578.242175782378;7761.904285842904;7829.530228186327;7832.334251588679;7916.84166316659;7499.362554182738;7617;7652.693892244471;7686.039245094364;7723.884141737991;6882.552634078769;6917.757878474229;6925.722971081101;6933.7226510939;6933.861322773415;6404.871902561829;6617.636030018395;6686.398224159849;6711.463082953254;6717.361850624378;6462.612243265419;6507.902381464187;6517.478601711947;6546.345365463606;6547.934520654732 18:32:02 INFO - 2015-10-21 18:32:02,582 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.2524826303163;303.30694363379666;306.49581438533625;309.66092129118636;315.4133312039606;5374.973125134378;5463.945360546399;5484.945150548493;5511.476409741078;5584.776608935643;5296.443873393287;5445.128779395298;5491.478309560585;5503.697296648683;5554.91667624986;4249.1714115747445;4289.828406863721;4301.268784306675;4308.590683885026;4328.0045589514275;4151.916961660765;4189.832406703744;4273.679474039444;4299.312110062375;4339.262325404688;4266.360045993095;4270.786460676969;4271.31658934569;4276.700630955835;4278.058827058057;4215.199112168678;4229.133027729339;4242.7242229255;4244.448221731171;4253.276942919681;3728.5525736911745;3737.5141231639986;3741.5884252732176;3747.3254814133447;3747.831347589338;5215.6609820361555;5339.813106541291;5359.115745901921;5362.973185134088;5372.274742909696;4727;4733.219018861883;4736.2658787887585;4752.857414277577;4755.072760811643;5445.156000819879;5617.606767526275;5622.381538030813;5657.603967722261;5664.405237450091;3921.4706014687936;3950.0914789598264;3994.4208089827102;4015.4980627421573;4037.4145748866545;5642.492175704166;5780.017397042513;5799.101139323411;5800.53595712342;5815.011448053841;4031.234065527599;4055.918881622351;4062.5531191568903;4066.755994640331;4068.247374235776;4087.550369459357;4123.835046598102;4125.339945608688;4132.40080188371;4140.254754144223;4617.376654151646;4688.789004494806;4695.694779839299;4700.482946875841;4718;5603;5610.719464026783;5614.1859430382365;5618;5645.661260324394;1469.2873956131268;1495.0655840099937;1495.9925200374146;1497.1241823533137;1499.7225513280077;983.3460748602099;991.2070343724992;1007.1036777268237;1010.838265877456;1015.4364327797995;5339.385970613352;5346.1713434417725;5369.677819330853;5373.785048598091;5392.029434701792;5851.122331650201;5868.706564671749;5871.706414679335;5881.382454842265;5886.558508111909;5334.253204551366;5348.973255133699;5362.2224777407055;5362.51737343641;5385.9730701347025;3148.5906832112137;3202.8398580070902;3223.7259832914465;3237.3848968695875;3246.7077962983444;5886.529077673776;5896.823095307148;5912.3496415394275;5950.9107363389585;6006.819795406145;5970.134330522137;5977.820665379959;5985.25184351956;5999.100134979701;6011.398860113954;5791.044477661223;5895.498882595028;5906.940930590725;5937.584369094122;5961.135635332939;5837.211976383134;5848.64908105515;5919.7040147991565;5922.082077278029;5962.612430192024;5621.578381621313;5697.4302569742695;5708.65748055118;5770.365259821332;5797.159411885337;5936;5943.970280148572;5980.5215582754145;5983.581149319506;6015;3890.8054597269456;3928.489296391451;3930.2139572085125;3943.546492153439;3954.268460334847;5763.193152958673;5766.221560089502;5886.087656413263;5898.469137777621;5910.52715782745;5751.511121554715;5765.423457654201;5777.133429985536;5788.102844059177;5797.79707710245;5711.485966263056;5720.542356611378;5727.455891690282;5728.942710572841;5768.163616275533;5436.456354364532;5627.943720562906;5644.858878527905;5646.983542962306;5652.123920792284;5682.914756278742;5688.11834165705;5689.118186681071;5699.202111704281;5722.141678748221;5568.77724891016;5608.383077861514;5616;5633.126865335879;5662.518685911744 18:32:02 INFO - 2015-10-21 18:32:02,582 DEBUG : BROWSER_OUTPUT: |5;yui.html;684.2712511175598;689.9413549848263;696.4706822814662;710.2826145592951;749.2657195947968;11414.71463213419;11607.245529040607;11620.709482262937;11625.47685354159;11665.70835729105;10686.788109695608;11164.832527512073;11308.830367544493;11310.717232069203;11374.260673056246;635.5773410681891;647.1489990662287;785.2579312549643;801.1187693537091;808.1716240853114;765.2156539546982;791.8060075281564;811.8741595052746;812.2689579378548;813.446856137826;837.3217693668117;838.995805020974;842.5576572299561;847.3179090831878;858.3390789092396;656.0389030070945;661.6757788683559;834.4951304460775;849.7153453593054;859.0807835615893;617.9073139029136;620.5159975219336;621.9657918814463;627.6328347916474;630.3192552043781;11267.21129520934;11357.886421135765;11449.828252576219;11464;11478.196526243166;9578.521073946275;9645.08371704687;10079.143272821819;10243.897561024369;10303.3817970922;7715.884261736079;7836.647350869168;7913.525188488651;7943.126256111823;7999.400044996591;2882.6252587163535;2976.583278341034;2981.6720160782297;3019.230096325423;3046.466868298061;34144.658553414396;34495.31009379798;34549.309013819584;35150.64849351499;36671.81664091689;7273.818154546073;7445.590492522963;7629.3133617974645;7681.692732290758;7821.765347039598;16131.112788796494;16175;16180.271887765079;16212.270447829877;16216.83783162177;5913.970430147908;5962.105684147413;5966.19456373384;6113.144159817629;6140.2017737694705;3232.2727386338356;3297.2242042602684;3298.1733729193747;3303.240254741423;3312.5528053712924;2687.422204226101;2699.1767510908967;2707.7969152313262;2720.9047683330987;2724.7002829688718;379.97340186187256;381.2717709175462;384.88838236911545;386.25452875949685;386.52650503133435;456.0878243512974;477.29122253453596;505.14882423117166;560.403170623285;560.4087687489738;6837.35045170708;6885.414739747077;7016.92983070173;7043;7082;449.6313023320911;509.2564855311213;535.2800483349888;549.8240563019875;569.487461284847;3328.2012317043736;3377.4427219508507;3434.1586311353876;3477.3566890125408;3586.7309951753723;41804.58195418068;41821;42397.788011060366;42455;42625;34387.656123438945;34703.479447808306;35056.82471587677;35873.64126358703;36466.08834779152;29935;30466.390672186433;30556.541651875683;32006.35987280288;32620.836895815843;6748.122744043243;6897.7240910365035;7031.879845925543;7052.435805135679;7227.530210536509;22419.77580224177;22976.655350169425;23061.65407518922;23071.769282306963;23268.418289542897;29834.254143645714;29927.401451970403;30134.397312054076;30174.84912575423;30274.84862575673;6009;6224.9377506224355;6396.744130234924;6417.550771445954;6602.273749887605;9088.454692718458;9213.769655758391;9271.98008219082;9322.720318390458;9370.34407591462;8752.984426041188;8793.164649358301;9115.863262050942;9265.351425400428;9376.859347109663;8587.742367728979;8718.8523529354;8954.597043133204;8974.56406974907;9107.590158442754;8654.567271636268;8708.216260536583;8929.151730585583;8960.775980600538;9194.58624361892;7690.8511062388325;7714.267144621252;7889.802754931173;7912.802179945547;7972.402069844901;7198.6040767756185;7636.389088872766;7717.112532058885;7969.6015199240965;7982.241687039722 18:32:02 INFO - 2015-10-21 18:32:02,582 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:32:02 INFO - 2015-10-21 18:32:02,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:32:02 INFO - 2015-10-21 18:32:02,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1071 18:32:02 INFO - 2015-10-21 18:32:02,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1445477522569__endTimestamp 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,585 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5026.13 Median:5168.17 stddev:533.00 (10.3%) stddev-sans-first:509.58 18:32:02 INFO - 2015-10-21 18:32:02,586 DEBUG : BROWSER_OUTPUT: Values: 2967.3 2994.9 3008.1 3034.2 3132.5 4862.5 5093.9 5229.6 5237.9 5240.1 5101.5 5132.8 5137.2 5215.7 5244.2 4672.2 4687.6 4694.9 4701.0 4742.9 4740.5 4755.1 4789.7 4800.2 4838.9 4613.4 4724.7 4729.9 4730.6 4736.8 4650.9 4681.4 4684.2 4688.6 4777.7 4557.2 4670.6 4681.0 4681.7 4697.2 5043.2 5067.9 5071.5 5098.7 5101.5 5285.2 5295.4 5306.4 5313.5 5376.0 5235.6 5405.4 5413.3 5418.1 5445.8 4967.9 4993.1 5060.9 5101.2 5119.7 5473.5 5504.5 5530.0 5548.8 5622.0 5084.6 5272.6 5284.9 5292.7 5361.4 5281.6 5360.7 5375.8 5387.1 5437.7 5322.2 5376.7 5390.3 5396.1 5397.0 5169.0 5389.9 5395.8 5436.6 5490.7 4071.3 4155.4 4164.6 4181.8 4188.7 3703.2 3707.7 3719.1 3719.5 3784.6 4969.6 4971.8 4985.2 5000.1 5050.4 5182.4 5348.2 5355.8 5370.1 5471.9 5004.7 5025.0 5028.5 5032.3 5043.4 4752.8 4754.5 4756.5 4806.8 4825.6 5344.2 5436.0 5498.8 5503.0 5563.5 5499.3 5504.3 5532.2 5536.3 5597.2 5532.9 5569.7 5581.8 5603.0 5630.9 5031.8 5168.2 5183.8 5257.5 5306.1 5240.9 5339.4 5439.6 5460.7 5508.5 5301.8 5329.8 5354.0 5354.8 5391.1 5040.3 5143.4 5172.9 5184.8 5281.3 5095.2 5122.8 5134.6 5163.3 5208.2 5258.6 5292.6 5304.3 5326.5 5356.9 4978.5 5066.7 5088.1 5109.6 5186.7 18:32:02 INFO - 2015-10-21 18:32:02,586 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,586 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41880.31 Median:29171.06 stddev:70641.08 (242.2%) stddev-sans-first:70770.82 18:32:02 INFO - 2015-10-21 18:32:02,587 DEBUG : BROWSER_OUTPUT: Values: 467.9 470.9 474.2 475.9 508.7 28038.0 29104.1 35205.0 35213.0 35817.6 37598.4 38333.0 38473.2 38540.3 38582.0 7563.1 8322.5 8442.2 8523.4 8531.5 7480.1 9960.5 10265.3 10279.9 10316.7 10022.7 10119.6 10141.9 10142.6 10172.4 7663.5 7866.1 9863.8 9969.9 10075.6 9833.5 9966.9 10007.8 10008.7 10056.1 36131.6 36405.5 36551.3 36583.0 36607.6 2762.2 2862.3 2947.3 3233.6 3306.2 24477.0 24535.9 24684.6 25156.1 25639.9 1891.8 1906.6 1924.4 1929.7 1961.7 254424.0 255916.0 256871.0 256941.0 258225.0 51086.2 51164.0 51358.5 51449.0 51484.7 51701.0 53709.5 53820.7 55406.7 56288.7 13862.6 13964.5 14189.3 14192.5 14263.1 10442.4 10541.7 10551.4 10566.2 10602.6 16031.2 16108.9 16111.2 16115.7 16148.7 7708.5 8020.9 8029.7 8052.9 8065.9 827.9 875.7 932.0 947.9 961.3 25539.4 25828.2 25958.9 27138.5 27910.2 908.4 932.9 964.7 972.4 1005.4 12838.6 12841.6 13093.3 13152.3 13258.7 280796.0 284821.0 286978.0 287730.0 287768.0 46832.8 47159.1 47206.8 47247.8 47444.3 1204.8 1220.6 1240.0 1244.8 1253.5 24257.9 24682.4 24821.9 24851.0 24882.5 42098.0 42484.4 42531.8 42671.1 42748.8 266592.0 267479.0 267694.0 268617.0 269483.0 23598.9 24203.9 26711.6 29153.3 29754.1 36125.0 36210.8 36280.3 36386.8 36680.8 29953.0 30286.2 30867.2 30918.4 31195.0 24367.8 26938.0 30043.8 30504.1 31020.4 29188.9 29420.1 29469.7 29503.7 29635.1 26036.7 27541.6 28168.3 29521.6 29826.7 21381.9 21408.0 21683.7 21818.0 21909.7 18:32:02 INFO - 2015-10-21 18:32:02,587 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,587 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21027.78 Median:2429.01 stddev:63170.76 (2600.7%) stddev-sans-first:63328.81 18:32:02 INFO - 2015-10-21 18:32:02,589 DEBUG : BROWSER_OUTPUT: Values: 302.8 311.3 313.4 324.6 325.6 12961.0 12981.5 15398.0 15617.4 15915.9 10524.0 10849.0 10875.4 14333.8 16089.8 4021.8 4140.6 4149.7 4159.5 4163.2 3134.5 3228.0 3928.7 4112.2 4345.8 4370.9 4374.8 4409.8 4415.6 4430.6 4263.4 4386.6 4387.0 4387.2 4391.7 3662.8 3683.3 3687.6 3692.9 3694.2 11732.1 11954.5 11991.3 12018.0 12114.9 1649.8 1658.8 1693.8 1731.0 1755.4 8595.9 8625.9 8747.5 8842.5 8990.8 1368.8 1401.7 1405.3 1413.8 1448.4 52818.7 55711.7 56108.7 56228.4 57197.7 5640.8 5692.8 5720.1 5764.0 5789.3 6547.3 6591.1 6623.8 6641.3 6648.8 4765.7 4841.1 4864.8 4880.9 4885.8 5148.1 5156.6 5172.6 5190.0 5233.3 2597.9 2616.5 2621.4 2639.5 2640.2 933.4 935.6 945.9 949.0 980.2 344.1 345.1 384.4 398.7 400.1 9677.9 10106.3 10247.0 10302.0 10377.7 354.8 380.2 407.3 434.4 440.7 5379.8 5540.9 5583.2 5601.3 5616.1 339179.0 344736.0 345032.0 346446.0 512312.0 61407.7 62965.7 63228.7 65000.7 65065.7 431.4 442.4 444.7 447.2 447.2 9334.3 9336.8 9427.8 9691.2 10017.4 30242.1 31768.7 31800.4 32783.3 32990.0 43996.0 44074.8 44209.0 44620.3 45127.3 6631.9 6872.7 6986.1 6996.1 7019.2 10519.5 10527.4 10672.9 10690.4 10765.6 8856.7 9078.1 9126.0 9150.2 9165.7 8110.6 8160.7 8576.2 8690.2 8879.5 9116.8 9122.5 9144.9 9395.8 9435.3 6709.1 6871.0 6896.0 6896.8 6907.4 8277.3 8460.8 9077.6 9089.5 9187.0 18:32:02 INFO - 2015-10-21 18:32:02,589 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,589 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5866.40 Median:5645.57 stddev:3295.62 (58.4%) stddev-sans-first:3286.45 18:32:02 INFO - 2015-10-21 18:32:02,590 DEBUG : BROWSER_OUTPUT: Values: 1232.0 1299.5 1433.8 1440.8 1691.6 7882.1 8273.3 8657.9 8831.4 8859.1 8329.2 8439.7 8467.0 8491.7 8498.7 2137.5 2170.0 2182.3 2184.0 2191.5 2211.3 2226.9 2288.8 2297.9 2304.5 2195.4 2204.8 2221.7 2229.5 2231.6 2134.5 2143.3 2153.7 2161.4 2163.7 2205.1 2217.3 2224.1 2224.2 2225.9 7725.9 8313.7 8351.7 8398.6 8466.4 4482.7 4982.1 5116.3 5124.6 5137.3 2905.9 2922.5 2981.1 2985.6 3029.2 849.3 854.9 886.1 894.5 1353.0 12408.2 12499.9 12511.2 12544.2 12697.2 4373.3 4452.9 4517.8 4533.5 4535.1 9701.7 9709.5 9711.9 9713.5 9729.0 5094.9 5111.0 5111.2 5118.1 5144.2 4647.1 4653.5 4655.4 4661.6 4674.5 3367.7 3468.2 3468.7 3468.8 3490.3 1013.6 1031.7 1043.1 1044.6 1047.4 1195.7 1221.2 1257.0 1257.1 1274.7 8100.8 8308.8 8341.3 8362.8 8380.2 447.2 454.6 467.4 467.4 469.3 5609.1 5682.0 5685.4 5716.8 5937.6 9826.4 10699.2 10877.2 10879.0 10890.6 10506.4 10642.3 10708.9 10850.5 10861.9 8039.6 8103.8 8129.0 8129.9 8169.1 7909.5 8115.9 8146.5 8192.9 8212.4 8962.2 9226.5 9249.5 9324.2 9391.0 9202.5 9484.1 9669.2 9710.7 9717.0 7512.7 7618.4 7634.8 7679.7 7750.3 8423.2 8433.9 8437.1 8455.3 8456.9 7578.2 7761.9 7829.5 7832.3 7916.8 7499.4 7617.0 7652.7 7686.0 7723.9 6882.6 6917.8 6925.7 6933.7 6933.9 6404.9 6617.6 6686.4 6711.5 6717.4 6462.6 6507.9 6517.5 6546.3 6547.9 18:32:02 INFO - 2015-10-21 18:32:02,590 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,591 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4773.75 Median:5440.79 stddev:1402.33 (25.8%) stddev-sans-first:1365.53 18:32:02 INFO - 2015-10-21 18:32:02,591 DEBUG : BROWSER_OUTPUT: Values: 303.3 303.3 306.5 309.7 315.4 5375.0 5463.9 5484.9 5511.5 5584.8 5296.4 5445.1 5491.5 5503.7 5554.9 4249.2 4289.8 4301.3 4308.6 4328.0 4151.9 4189.8 4273.7 4299.3 4339.3 4266.4 4270.8 4271.3 4276.7 4278.1 4215.2 4229.1 4242.7 4244.4 4253.3 3728.6 3737.5 3741.6 3747.3 3747.8 5215.7 5339.8 5359.1 5363.0 5372.3 4727.0 4733.2 4736.3 4752.9 4755.1 5445.2 5617.6 5622.4 5657.6 5664.4 3921.5 3950.1 3994.4 4015.5 4037.4 5642.5 5780.0 5799.1 5800.5 5815.0 4031.2 4055.9 4062.6 4066.8 4068.2 4087.6 4123.8 4125.3 4132.4 4140.3 4617.4 4688.8 4695.7 4700.5 4718.0 5603.0 5610.7 5614.2 5618.0 5645.7 1469.3 1495.1 1496.0 1497.1 1499.7 983.3 991.2 1007.1 1010.8 1015.4 5339.4 5346.2 5369.7 5373.8 5392.0 5851.1 5868.7 5871.7 5881.4 5886.6 5334.3 5349.0 5362.2 5362.5 5386.0 3148.6 3202.8 3223.7 3237.4 3246.7 5886.5 5896.8 5912.3 5950.9 6006.8 5970.1 5977.8 5985.3 5999.1 6011.4 5791.0 5895.5 5906.9 5937.6 5961.1 5837.2 5848.6 5919.7 5922.1 5962.6 5621.6 5697.4 5708.7 5770.4 5797.2 5936.0 5944.0 5980.5 5983.6 6015.0 3890.8 3928.5 3930.2 3943.5 3954.3 5763.2 5766.2 5886.1 5898.5 5910.5 5751.5 5765.4 5777.1 5788.1 5797.8 5711.5 5720.5 5727.5 5728.9 5768.2 5436.5 5627.9 5644.9 5647.0 5652.1 5682.9 5688.1 5689.1 5699.2 5722.1 5568.8 5608.4 5616.0 5633.1 5662.5 18:32:02 INFO - 2015-10-21 18:32:02,591 DEBUG : BROWSER_OUTPUT: 18:32:02 INFO - 2015-10-21 18:32:02,591 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10240.89 Median:5987.60 stddev:11103.29 (185.4%) stddev-sans-first:11111.24 18:32:02 INFO - 2015-10-21 18:32:02,592 DEBUG : BROWSER_OUTPUT: Values: 684.3 689.9 696.5 710.3 749.3 11414.7 11607.2 11620.7 11625.5 11665.7 10686.8 11164.8 11308.8 11310.7 11374.3 635.6 647.1 785.3 801.1 808.2 765.2 791.8 811.9 812.3 813.4 837.3 839.0 842.6 847.3 858.3 656.0 661.7 834.5 849.7 859.1 617.9 620.5 622.0 627.6 630.3 11267.2 11357.9 11449.8 11464.0 11478.2 9578.5 9645.1 10079.1 10243.9 10303.4 7715.9 7836.6 7913.5 7943.1 7999.4 2882.6 2976.6 2981.7 3019.2 3046.5 34144.7 34495.3 34549.3 35150.6 36671.8 7273.8 7445.6 7629.3 7681.7 7821.8 16131.1 16175.0 16180.3 16212.3 16216.8 5914.0 5962.1 5966.2 6113.1 6140.2 3232.3 3297.2 3298.2 3303.2 3312.6 2687.4 2699.2 2707.8 2720.9 2724.7 380.0 381.3 384.9 386.3 386.5 456.1 477.3 505.1 560.4 560.4 6837.4 6885.4 7016.9 7043.0 7082.0 449.6 509.3 535.3 549.8 569.5 3328.2 3377.4 3434.2 3477.4 3586.7 41804.6 41821.0 42397.8 42455.0 42625.0 34387.7 34703.5 35056.8 35873.6 36466.1 29935.0 30466.4 30556.5 32006.4 32620.8 6748.1 6897.7 7031.9 7052.4 7227.5 22419.8 22976.7 23061.7 23071.8 23268.4 29834.3 29927.4 30134.4 30174.8 30274.8 6009.0 6224.9 6396.7 6417.6 6602.3 9088.5 9213.8 9272.0 9322.7 9370.3 8753.0 8793.2 9115.9 9265.4 9376.9 8587.7 8718.9 8954.6 8974.6 9107.6 8654.6 8708.2 8929.2 8960.8 9194.6 7690.9 7714.3 7889.8 7912.8 7972.4 7198.6 7636.4 7717.1 7969.6 7982.2 18:32:02 INFO - 2015-10-21 18:32:02,593 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:32:02 INFO - 2015-10-21 18:32:02,593 DEBUG : BROWSER_OUTPUT: 18:32:03 INFO - 2015-10-21 18:32:03,125 INFO : Browser exited with error code: 0 18:32:03 INFO - 2015-10-21 18:32:03,154 INFO : Completed test dromaeo_css (00:18:36) 18:32:03 INFO - 2015-10-21 18:32:03,154 INFO : Starting test kraken 18:32:03 INFO - 2015-10-21 18:32:03,154 DEBUG : operating with platform_type : mac_ 18:32:03 INFO - 2015-10-21 18:32:03,154 INFO : Initialising browser for kraken test... 18:32:03 INFO - 2015-10-21 18:32:03,168 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpifC9su/profile http://localhost:49271/getInfo.html 18:32:05 INFO - 2015-10-21 18:32:05,541 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:32:05 INFO - 2015-10-21 18:32:05,541 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:32:05 INFO - 2015-10-21 18:32:05,542 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:32:05 INFO - 2015-10-21 18:32:05,542 DEBUG : BROWSER_OUTPUT: __metrics 18:32:05 INFO - 2015-10-21 18:32:05,559 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:32:06 INFO - 2015-10-21 18:32:06,299 INFO : Browser initialized. 18:32:06 INFO - 2015-10-21 18:32:06,299 INFO : Running cycle 1/1 for kraken test... 18:32:06 INFO - 2015-10-21 18:32:06,299 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpifC9su/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:32:18 INFO - 2015-10-21 18:32:18,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 226250752 18:32:18 INFO - 2015-10-21 18:32:18,286 DEBUG : BROWSER_OUTPUT: 18:32:20 INFO - 2015-10-21 18:32:20,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 18:32:21 INFO - 2015-10-21 18:32:21,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 274395136 18:32:21 INFO - 2015-10-21 18:32:21,532 DEBUG : BROWSER_OUTPUT: 18:32:24 INFO - 2015-10-21 18:32:24,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 18:32:25 INFO - 2015-10-21 18:32:25,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 279015424 18:32:25 INFO - 2015-10-21 18:32:25,013 DEBUG : BROWSER_OUTPUT: 18:32:28 INFO - 2015-10-21 18:32:28,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 18:32:28 INFO - 2015-10-21 18:32:28,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 259321856 18:32:28 INFO - 2015-10-21 18:32:28,808 DEBUG : BROWSER_OUTPUT: 18:32:30 INFO - 2015-10-21 18:32:30,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 18:32:31 INFO - 2015-10-21 18:32:31,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 259084288 18:32:31 INFO - 2015-10-21 18:32:31,571 DEBUG : BROWSER_OUTPUT: 18:32:34 INFO - 2015-10-21 18:32:34,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:34 INFO - 2015-10-21 18:32:34,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 257359872 18:32:34 INFO - 2015-10-21 18:32:34,614 DEBUG : BROWSER_OUTPUT: 18:32:37 INFO - 2015-10-21 18:32:37,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:38 INFO - 2015-10-21 18:32:38,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 262012928 18:32:38 INFO - 2015-10-21 18:32:38,509 DEBUG : BROWSER_OUTPUT: 18:32:41 INFO - 2015-10-21 18:32:41,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:42 INFO - 2015-10-21 18:32:42,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 264908800 18:32:42 INFO - 2015-10-21 18:32:42,491 DEBUG : BROWSER_OUTPUT: 18:32:45 INFO - 2015-10-21 18:32:45,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 18:32:46 INFO - 2015-10-21 18:32:46,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 265859072 18:32:46 INFO - 2015-10-21 18:32:46,192 DEBUG : BROWSER_OUTPUT: 18:32:47 INFO - 2015-10-21 18:32:47,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:48 INFO - 2015-10-21 18:32:48,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 294592512 18:32:48 INFO - 2015-10-21 18:32:48,418 DEBUG : BROWSER_OUTPUT: 18:32:50 INFO - 2015-10-21 18:32:50,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:50 INFO - 2015-10-21 18:32:50,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 299204608 18:32:50 INFO - 2015-10-21 18:32:50,885 DEBUG : BROWSER_OUTPUT: 18:32:53 INFO - 2015-10-21 18:32:53,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:53 INFO - 2015-10-21 18:32:53,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 310874112 18:32:53 INFO - 2015-10-21 18:32:53,709 DEBUG : BROWSER_OUTPUT: 18:32:56 INFO - 2015-10-21 18:32:56,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:57 INFO - 2015-10-21 18:32:57,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 311332864 18:32:57 INFO - 2015-10-21 18:32:57,099 DEBUG : BROWSER_OUTPUT: 18:32:59 INFO - 2015-10-21 18:32:59,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:33:00 INFO - 2015-10-21 18:33:00,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 309362688 18:33:00 INFO - 2015-10-21 18:33:00,476 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 18:33:02 INFO - 2015-10-21 18:33:02,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 362885120 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;116;108;112;115;113;114;116;110;114 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;155;167;179;161;157;161;158;181;157 18:33:02 INFO - 2015-10-21 18:33:02,589 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;179;177;175;172;178;180;180;210;188 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;88;91;109;93;91;90;89;99;89 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;116;151;115;116;117;151;116;117;159 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;133;130;130;141;132;137;135;135;129;136 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;141;141;141;141;141;141;141;141;141 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;113;117;118;114;115;112;119;117;113 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;65;65;66;66;65;75;65;64 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;71;72;71;72;71;71;71;71 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;95;95;96;97;100;96;97;97;95 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;149;146;141;148;140;146;149;152;136 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;166;165;166;170;168;168;166;167;155 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;82;82;81;81;81;82;80;80;81 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:33:02 INFO - 2015-10-21 18:33:02,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,894 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: __startTimestamp1445477582581__endTimestamp 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.64 (2.3%) stddev-sans-first:2.71 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: Values: 111.0 116.0 108.0 112.0 115.0 113.0 114.0 116.0 110.0 114.0 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:163.10 Median:161.00 stddev:9.60 (6.0%) stddev-sans-first:9.72 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: Values: 155.0 155.0 167.0 179.0 161.0 157.0 161.0 158.0 181.0 157.0 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,591 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.10 Median:179.50 stddev:11.15 (6.2%) stddev-sans-first:11.33 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: Values: 172.0 179.0 177.0 175.0 172.0 178.0 180.0 180.0 210.0 188.0 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.30 Median:90.50 stddev:7.01 (7.7%) stddev-sans-first:6.76 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: Values: 84.0 88.0 91.0 109.0 93.0 91.0 90.0 89.0 99.0 89.0 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.70 Median:117.00 stddev:18.87 (16.1%) stddev-sans-first:18.90 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: Values: 109.0 116.0 151.0 115.0 116.0 117.0 151.0 116.0 117.0 159.0 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.80 Median:135.00 stddev:3.74 (2.8%) stddev-sans-first:3.95 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: Values: 133.0 130.0 130.0 141.0 132.0 137.0 135.0 135.0 129.0 136.0 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:141.10 Median:141.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 141.0 141.0 141.0 141.0 141.0 141.0 141.0 141.0 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,592 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.20 Median:116.00 stddev:2.39 (2.1%) stddev-sans-first:2.50 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: Values: 114.0 113.0 117.0 118.0 114.0 115.0 112.0 119.0 117.0 113.0 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:3.43 (5.3%) stddev-sans-first:3.50 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 65.0 65.0 66.0 66.0 65.0 75.0 65.0 64.0 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:1.90 (2.7%) stddev-sans-first:1.17 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 71.0 72.0 71.0 72.0 71.0 71.0 71.0 71.0 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:96.00 stddev:2.53 (2.6%) stddev-sans-first:1.59 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: Values: 90.0 95.0 95.0 96.0 97.0 100.0 96.0 97.0 97.0 95.0 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:147.00 stddev:5.38 (3.7%) stddev-sans-first:5.17 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 146.0 141.0 148.0 140.0 146.0 149.0 152.0 136.0 18:33:02 INFO - 2015-10-21 18:33:02,593 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:4.19 (2.5%) stddev-sans-first:4.27 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: Values: 162.0 166.0 165.0 166.0 170.0 168.0 168.0 166.0 167.0 155.0 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.80 Median:81.00 stddev:1.23 (1.5%) stddev-sans-first:0.78 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: Values: 78.0 82.0 82.0 81.0 81.0 81.0 82.0 80.0 80.0 81.0 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:33:02 INFO - 2015-10-21 18:33:02,594 DEBUG : BROWSER_OUTPUT: 18:33:03 INFO - 2015-10-21 18:33:03,290 INFO : Browser exited with error code: 0 18:33:03 INFO - 2015-10-21 18:33:03,341 INFO : Completed test kraken (00:01:00) 18:33:03 INFO - 2015-10-21 18:33:03,341 INFO : Starting test v8_7 18:33:03 INFO - 2015-10-21 18:33:03,341 DEBUG : operating with platform_type : mac_ 18:33:03 INFO - 2015-10-21 18:33:03,341 INFO : Initialising browser for v8_7 test... 18:33:03 INFO - 2015-10-21 18:33:03,355 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmptkR1ap/profile http://localhost:49271/getInfo.html 18:33:05 INFO - 2015-10-21 18:33:05,674 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:33:05 INFO - 2015-10-21 18:33:05,674 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:33:05 INFO - 2015-10-21 18:33:05,675 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:33:05 INFO - 2015-10-21 18:33:05,675 DEBUG : BROWSER_OUTPUT: __metrics 18:33:05 INFO - 2015-10-21 18:33:05,691 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:33:06 INFO - 2015-10-21 18:33:06,493 INFO : Browser initialized. 18:33:06 INFO - 2015-10-21 18:33:06,493 INFO : Running cycle 1/1 for v8_7 test... 18:33:06 INFO - 2015-10-21 18:33:06,493 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmptkR1ap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:33:18 INFO - 2015-10-21 18:33:18,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 222515200 18:33:18 INFO - 2015-10-21 18:33:18,466 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 668831744 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:33:41 INFO - 2015-10-21 18:33:41,257 DEBUG : BROWSER_OUTPUT: |0;Richards;175.07002801120447 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;231.5886984715146 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |2;Encrypt;349.8950314905528 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6629.139072847682 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2293.577981651376 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |5;Earley;1003.0090270812437 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |6;Boyer;14126.760563380281 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |7;RegExp;33377.04918032787 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |8;Splay;833.3333333333334 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6407.643312101911 18:33:41 INFO - 2015-10-21 18:33:41,258 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: __startTimestamp1445477621254__endTimestamp 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:175.07 Median:175.07 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: Values: 175.1 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:231.59 Median:231.59 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: Values: 231.6 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:349.90 Median:349.90 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: Values: 349.9 18:33:41 INFO - 2015-10-21 18:33:41,259 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6629.14 Median:6629.14 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: Values: 6629.1 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2293.58 Median:2293.58 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: Values: 2293.6 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1003.01 Median:1003.01 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: Values: 1003.0 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14126.76 Median:14126.76 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: Values: 14126.8 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33377.05 Median:33377.05 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: Values: 33377.0 18:33:41 INFO - 2015-10-21 18:33:41,260 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:833.33 Median:833.33 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: Values: 833.3 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6407.64 Median:6407.64 stddev:0.00 (0.0%) 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: Values: 6407.6 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:33:41 INFO - 2015-10-21 18:33:41,261 DEBUG : BROWSER_OUTPUT: 18:33:41 INFO - 2015-10-21 18:33:41,981 INFO : Browser exited with error code: 0 18:33:42 INFO - 2015-10-21 18:33:42,004 INFO : Completed test v8_7 (00:00:38) 18:33:42 INFO - 2015-10-21 18:33:42,341 INFO : Completed test suite (00:20:15) 18:33:42 INFO - 2015-10-21 18:33:42,341 DEBUG : Working with test: dromaeo_css 18:33:42 INFO - 2015-10-21 18:33:42,341 DEBUG : Generating results file: dromaeo_css 18:33:42 INFO - 2015-10-21 18:33:42,342 DEBUG : Working with test: kraken 18:33:42 INFO - 2015-10-21 18:33:42,342 DEBUG : Generating results file: kraken 18:33:42 INFO - 2015-10-21 18:33:42,342 INFO : javascript benchmark 18:33:42 INFO - 2015-10-21 18:33:42,342 DEBUG : Working with test: v8_7 18:33:42 INFO - 2015-10-21 18:33:42,342 DEBUG : Generating results file: v8_7 18:33:42 INFO - 2015-10-21 18:33:42,342 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:33:42 INFO - 2015-10-21 18:33:42,404 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 18:33:42 INFO - 2015-10-21 18:33:42,404 DEBUG : process_Request line: dromaeo_css 6047.47 graph.html#tests=[[72,1,55]] 18:33:42 INFO - 2015-10-21 18:33:42,404 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:33:42 INFO - 2015-10-21 18:33:42,447 DEBUG : process_Request line: kraken 1688.70 graph.html#tests=[[232,1,55]] 18:33:42 INFO - 2015-10-21 18:33:42,447 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:33:42 INFO - 2015-10-21 18:33:42,479 DEBUG : process_Request line: v8_7 16077.45 graph.html#tests=[[230,1,55]] 18:33:42 INFO - 2015-10-21 18:33:42,480 INFO : javascript benchmark 18:33:42 INFO - 2015-10-21 18:33:42,482 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [302.8122564010313, 311.34928000478993, 313.4436375433605, 324.59587813172595, 325.6232865188, 12961.0, 12981.545645902395, 15398.0, 15617.438256174377, 15915.920420397897, 10524.0, 10849.023587877089, 10875.401852898107, 14333.78499322511, 16089.83910160898, 4021.8391264349466, 4140.565240649734, 4149.7095203335775, 4159.480064991876, 4163.20899029185, 3134.529820526928, 3228.047725920859, 3928.7249892507534, 4112.198121366335, 4345.826166953334, 4370.934435983447, 4374.825006999717, 4409.757463339515, 4415.602595766381, 4430.579094985971, 4263.4031235627035, 4386.561343865604, 4387.034852332514, 4387.210302145612, 4391.692581519295, 3662.7619204751873, 3683.28176005679, 3687.6128006559193, 3692.9076773080888, 3694.1872787986867, 11732.120090993125, 11954.521819127225, 11991.28052316855, 12018.0, 12114.878851211462, 1649.8102718187442, 1658.8009438867293, 1693.7882764654419, 1731.0306228512075, 1755.4382597568783, 8595.871061934076, 8625.870611940825, 8747.475151490868, 8842.5136617486, 8990.820183596357, 1368.7673095573775, 1401.6636007358263, 1405.2973513243378, 1413.7596608576464, 1448.4423496953748, 52818.73590632061, 55711.72144139294, 56108.71945640286, 56228.437715623135, 57197.71401143009, 5640.7743690252755, 5692.7722891083895, 5720.141978703145, 5763.971180144073, 5789.2763404574425, 6547.279799222082, 6591.143151390289, 6623.801285961429, 6641.269460359356, 6648.769977554168, 4765.7140571565815, 4841.12859685253, 4864.78108485119, 4880.8779780505065, 4885.780139893714, 5148.124818780816, 5156.5616922562, 5172.612054095958, 5190.0, 5233.267342572043, 2597.8701064946677, 2616.5290247755206, 2621.357767347012, 2639.4853003664102, 2640.155150351907, 933.3793027636546, 935.5743136872707, 945.938513996588, 949.0319873728758, 980.181548407088, 344.10303314958196, 345.0511094490152, 384.4003354766573, 398.7308566717454, 400.11774038245596, 9677.854832177523, 10106.292559520763, 10247.0, 10302.02130797573, 10377.688669339932, 354.7782635852592, 380.1920918049146, 407.25748656890346, 434.3549828504668, 440.69812178657725, 5379.78480860769, 5540.889182216333, 5583.246261754611, 5601.271834661468, 5616.129499927518, 339179.0, 344736.0, 345032.0, 346446.0, 512312.0, 61407.69296153491, 62965.68517157385, 63228.683856581345, 65000.67499662566, 65065.67467162634, 431.439129132127, 442.4248476979913, 444.6887178974666, 447.19728088081973, 447.2084410593297, 9334.25325973907, 9336.813263734552, 9427.764305892408, 9691.176250018827, 10017.39895606266, 30242.092737217037, 31768.682313177498, 31800.36399272048, 32783.34433311368, 32990.0, 43996.0, 44074.77962610166, 44209.0, 44620.33069504025, 45127.32309015302, 6631.933680663132, 6872.69072891711, 6986.091808064919, 6996.05553250325, 7019.19279282889, 10519.526621302213, 10527.368357898551, 10672.946635266773, 10690.358578485315, 10765.569377224823, 8856.734297971072, 9078.09219078087, 9125.954370228106, 9150.176484116195, 9165.679201227926, 8110.553919534483, 8160.714374996846, 8576.228139467477, 8690.174433429067, 8879.511626860585, 9116.817663646558, 9122.543872806466, 9144.908550914406, 9395.765105872408, 9435.29235307341, 6709.094272273181, 6871.0, 6896.034555162381, 6896.7586134485055, 6907.447404207551, 8277.337812975067, 8460.788480288042, 9077.636894524145, 9089.454632722058, 9186.954065229898], "dojo.html": [2967.3175169710953, 2994.850257487125, 3008.1426793363867, 3034.150437877394, 3132.5301204819275, 4862.489438608948, 5093.9235911461265, 5229.581633469323, 5237.8952420951555, 5240.109181439155, 5101.464346243647, 5132.769025393857, 5137.17805151175, 5215.660982036165, 5244.187150991593, 4672.2057250267535, 4687.578117969382, 4694.882627934295, 4700.976495117537, 4742.857714268577, 4740.454847692507, 4755.072760811626, 4789.688670236424, 4800.183968725325, 4838.854834354957, 4613.446386433616, 4724.692894961817, 4729.905401891977, 4730.574248317634, 4736.786844592001, 4650.906981860344, 4681.368015317923, 4684.227102528079, 4688.624910007191, 4777.689450185727, 4557.202489564346, 4670.626349892001, 4681.0, 4681.7190968542, 4697.154512187805, 5043.167877300241, 5067.949320506821, 5071.518205770446, 5098.745062746885, 5101.489851014906, 5285.245315441044, 5295.391030031557, 5306.3632364116165, 5313.521783039545, 5376.0, 5235.607329450307, 5405.37838148614, 5413.296271484682, 5418.106012507931, 5445.83662490126, 4967.875803104951, 4993.101241776515, 5060.924086138748, 5101.234814777776, 5119.744012799345, 5473.507384335429, 5504.532114770209, 5529.972350138223, 5548.805791797348, 5622.0, 5084.593232541388, 5272.630915835932, 5284.894302113936, 5292.708901010405, 5361.437049109865, 5281.603879709037, 5360.678359298455, 5375.784968601212, 5387.138057910715, 5437.728113594384, 5322.228276899906, 5376.7042812644895, 5390.326209223847, 5396.055690254189, 5397.0, 5169.043726910533, 5389.9191512127345, 5395.839894422639, 5436.6194366393975, 5490.670559766427, 4071.3078776607454, 4155.439015732837, 4164.604362585549, 4181.832726690898, 4188.727732697365, 3703.222323312081, 3707.6848467879995, 3719.1445967427103, 3719.5350581177354, 3784.6215378462484, 4969.552740253394, 4971.825986090469, 4985.152524070917, 5000.099982003201, 5050.419201791768, 5182.378114626194, 5348.197770334481, 5355.758990845421, 5370.060239458079, 5471.890562188734, 5004.699718016931, 5025.045241404122, 5028.547430731252, 5032.345795046621, 5043.36957880265, 4752.833650822274, 4754.500777418321, 4756.54812792791, 4806.759662016885, 4825.5898248649255, 5344.225087362311, 5435.972820135874, 5498.752556134984, 5502.972485137549, 5563.499285064364, 5499.312585926759, 5504.256925315031, 5532.170174473861, 5536.335639723259, 5597.160425936142, 5532.889342213214, 5569.693666848362, 5581.832545023656, 5603.0474819281635, 5630.859228519156, 5031.7735701894235, 5168.173092305213, 5183.792648294177, 5257.4742525747115, 5306.097963346318, 5240.947590524199, 5339.359276886798, 5439.5920305978, 5460.726963651881, 5508.504234618904, 5301.814436494704, 5329.786808527616, 5354.009508240988, 5354.839354819362, 5391.05656510117, 5040.319556859924, 5143.382794064736, 5172.922406163986, 5184.844454666366, 5281.313429254173, 5095.235714642833, 5122.769475373542, 5134.589232861437, 5163.302954101298, 5208.192730126836, 5258.553022993088, 5292.629515933848, 5304.310439642822, 5326.467353264643, 5356.866078348073, 4978.5270399312, 5066.746662666926, 5088.084144853814, 5109.565686916654, 5186.662866913639], "mootools.html": [1231.9815202771954, 1299.4542292237263, 1433.7849322601608, 1440.7550716378214, 1691.6447546015336, 7882.093559240689, 8273.338132949364, 8657.870131948026, 8831.381803273773, 8859.069797671233, 8329.208725171115, 8439.662413503467, 8467.0, 8491.702790402322, 8498.660053597863, 2137.4976880433087, 2170.0, 2182.2689399051255, 2184.006277143904, 2191.5069109450405, 2211.292386436341, 2226.9331920042346, 2288.828337874658, 2297.942551436219, 2304.539092181562, 2195.3523710505438, 2204.7574766775642, 2221.7222847144108, 2229.520653059592, 2231.6317807561813, 2134.4877229464973, 2143.303426386423, 2153.687715281283, 2161.3948094533557, 2163.7403511578555, 2205.106931692667, 2217.323716266538, 2224.1103558576538, 2224.1881713174735, 2225.9332220033425, 7725.884111738328, 8313.709020184264, 8351.749447516584, 8398.580070996486, 8466.365022623266, 4482.686211965164, 4982.103221420143, 5116.334876466073, 5124.615653825978, 5137.255098010804, 2905.8692358843905, 2922.517784565544, 2981.105668299523, 2985.5521671749193, 3029.242689327668, 849.3460035772421, 854.8760429737653, 886.1271647427279, 894.5303715549323, 1352.9797053044213, 12408.193467424588, 12499.875001249962, 12511.249325040435, 12544.24734515932, 12697.238165709994, 4373.343998400265, 4452.931296488884, 4517.841875534341, 4533.523979982055, 4535.070310586322, 9701.6604418845, 9709.465979371062, 9711.854322185172, 9713.514324283757, 9728.951355243178, 5094.923576146361, 5110.974445127825, 5111.182210846321, 5118.129917913963, 5144.202648589475, 4647.09381670571, 4653.488116307203, 4655.441347038377, 4661.580457758818, 4674.5325467452985, 3367.7305815534696, 3468.21965057865, 3468.705160061423, 3468.843902024415, 3490.336836001152, 1013.5591017907234, 1031.7008067660295, 1043.0664555223184, 1044.587387981743, 1047.3663433622548, 1195.748892732536, 1221.2062159596155, 1257.0258050011314, 1257.063487701668, 1274.7195616964252, 8100.83798324042, 8308.792280193044, 8341.290990265774, 8362.8327433451, 8380.16198380157, 447.20174488537805, 454.63856234293814, 467.3503829676752, 467.38538821449686, 469.25388632075163, 5609.102543593006, 5682.034054210794, 5685.374608793029, 5716.79991200306, 5937.584369094208, 9826.361286516354, 10699.197560183018, 10877.238593298393, 10879.020888120107, 10890.564377424815, 10506.369617822955, 10642.25504214713, 10708.89291107079, 10850.457477126112, 10861.945690271497, 8039.557824319601, 8103.837923241502, 8129.0, 8129.918700813035, 8169.101398846122, 7909.485883417559, 8115.878261826196, 8146.470479418819, 8192.918070819454, 8212.384071194565, 8962.193402593797, 9226.538673066454, 9249.491277979776, 9324.207442367204, 9391.0, 9202.493862837608, 9484.099010593982, 9669.226461883172, 9710.70867873965, 9717.028297170227, 7512.737054203077, 7618.352440042437, 7634.847303054019, 7679.731209407644, 7750.263724946121, 8423.199796019613, 8433.87349189775, 8437.114103019094, 8455.32357411418, 8456.915430845613, 7578.242175782378, 7761.904285842904, 7829.530228186327, 7832.334251588679, 7916.84166316659, 7499.362554182738, 7617.0, 7652.693892244471, 7686.039245094364, 7723.884141737991, 6882.552634078769, 6917.757878474229, 6925.722971081101, 6933.7226510939, 6933.861322773415, 6404.871902561829, 6617.636030018395, 6686.398224159849, 6711.463082953254, 6717.361850624378, 6462.612243265419, 6507.902381464187, 6517.478601711947, 6546.345365463606, 6547.934520654732], "ext.html": [467.87367410799084, 470.87757183132385, 474.23647926837805, 475.9262314341278, 508.7278306106234, 28038.0, 29104.126876193695, 35205.0, 35212.99999999997, 35817.64182358182, 37598.4360234596, 38333.0, 38473.230535389346, 38540.302178847494, 38582.0, 7563.092428908539, 8322.459040162385, 8442.197991190827, 8523.403361764678, 8531.530765807878, 7480.102387713482, 9960.452175130366, 10265.281430299845, 10279.948600256988, 10316.742081447948, 10022.699319020441, 10119.595216191343, 10141.949290253538, 10142.594296228142, 10172.38965662059, 7663.540187588706, 7866.0560732711865, 9863.802723945517, 9969.900300997042, 10075.596976120947, 9833.508324583814, 9966.850497242474, 10007.849882251772, 10008.749781255454, 10056.094951454332, 36131.63868361335, 36405.45391819125, 36551.26897462036, 36583.0, 36607.63392366096, 2762.1713485954333, 2862.2844288927768, 2947.263184203949, 3233.5634689316876, 3306.206510437502, 24477.0, 24535.87732061346, 24684.629730554057, 25156.11953581616, 25639.871800640878, 1891.7635295588052, 1906.551960289331, 1924.3745782620565, 1929.700237371967, 1961.7351657526194, 254424.0, 255916.0, 256871.0, 256941.0, 258225.0, 51086.23370649443, 51164.0, 51358.48641513612, 51449.0, 51484.74257628763, 51701.0, 53709.46290537123, 53820.73089634527, 55406.72296638491, 56288.71855640696, 13862.584122476343, 13964.511242106477, 14189.290535473185, 14192.503262385973, 14263.144211347353, 10442.425666588411, 10541.683749487527, 10551.419671918118, 10566.207534434949, 10602.575896964036, 16031.19844007795, 16108.919455402647, 16111.194440277939, 16115.677686446206, 16148.677026459405, 7708.49894756839, 8020.879686804703, 8029.678812847537, 8052.919470805217, 8065.879011814827, 827.8758186272107, 875.7416562114191, 932.0353434195575, 947.9478628675489, 961.3462845265286, 25539.36151596188, 25828.225153245432, 25958.87020564923, 27138.45723085527, 27910.16269511918, 908.4276905549593, 932.8507438809894, 964.7458304204506, 972.4408465132577, 1005.4470041477158, 12838.614841554769, 12841.614751557468, 13093.345332733325, 13152.342382881008, 13258.73482530344, 280796.0, 284821.0, 286978.0, 287730.0, 287768.0, 46832.7658361706, 47159.05681886343, 47206.76396618064, 47247.76376118166, 47444.288335674995, 1204.8012078007207, 1220.560598184653, 1239.9566015189425, 1244.807054906491, 1253.5424570031691, 24257.895630801315, 24682.382940425916, 24821.887146896428, 24851.0, 24882.502349952538, 42098.0, 42484.362734559625, 42531.7873410631, 42671.1465770689, 42748.78625606852, 266592.0, 267479.0, 267694.0, 268617.0, 269483.0, 23598.88200558986, 24203.878980604983, 26711.599326010513, 29153.271168220115, 29754.107376777865, 36125.0, 36210.82735035906, 36280.274394511434, 36386.81806591056, 36680.81659591685, 29953.0, 30286.242843928198, 30867.228319292197, 30918.381632366778, 31195.0, 24367.80689737932, 26938.0, 30043.849780751832, 30504.08487745371, 31020.379592408477, 29188.854055729586, 29420.11739647814, 29469.705302946695, 29503.704962950094, 29635.110946671633, 26036.739632603432, 27541.586876197274, 28168.29579260535, 29521.557176642797, 29826.70173298326, 21381.868351595193, 21408.0, 21683.674744878525, 21818.0, 21909.671354930008], "prototype.html": [303.2524826303163, 303.30694363379666, 306.49581438533625, 309.66092129118636, 315.4133312039606, 5374.973125134378, 5463.945360546399, 5484.945150548493, 5511.476409741078, 5584.776608935643, 5296.443873393287, 5445.128779395298, 5491.478309560585, 5503.697296648683, 5554.91667624986, 4249.1714115747445, 4289.828406863721, 4301.268784306675, 4308.590683885026, 4328.0045589514275, 4151.916961660765, 4189.832406703744, 4273.679474039444, 4299.312110062375, 4339.262325404688, 4266.360045993095, 4270.786460676969, 4271.31658934569, 4276.700630955835, 4278.058827058057, 4215.199112168678, 4229.133027729339, 4242.7242229255, 4244.448221731171, 4253.276942919681, 3728.5525736911745, 3737.5141231639986, 3741.5884252732176, 3747.3254814133447, 3747.831347589338, 5215.6609820361555, 5339.813106541291, 5359.115745901921, 5362.973185134088, 5372.274742909696, 4727.0, 4733.219018861883, 4736.2658787887585, 4752.857414277577, 4755.072760811643, 5445.156000819879, 5617.606767526275, 5622.381538030813, 5657.603967722261, 5664.405237450091, 3921.4706014687936, 3950.0914789598264, 3994.4208089827102, 4015.4980627421573, 4037.4145748866545, 5642.492175704166, 5780.017397042513, 5799.101139323411, 5800.53595712342, 5815.011448053841, 4031.234065527599, 4055.918881622351, 4062.5531191568903, 4066.755994640331, 4068.247374235776, 4087.550369459357, 4123.835046598102, 4125.339945608688, 4132.40080188371, 4140.254754144223, 4617.376654151646, 4688.789004494806, 4695.694779839299, 4700.482946875841, 4718.0, 5603.0, 5610.719464026783, 5614.1859430382365, 5618.0, 5645.661260324394, 1469.2873956131268, 1495.0655840099937, 1495.9925200374146, 1497.1241823533137, 1499.7225513280077, 983.3460748602099, 991.2070343724992, 1007.1036777268237, 1010.838265877456, 1015.4364327797995, 5339.385970613352, 5346.1713434417725, 5369.677819330853, 5373.785048598091, 5392.029434701792, 5851.122331650201, 5868.706564671749, 5871.706414679335, 5881.382454842265, 5886.558508111909, 5334.253204551366, 5348.973255133699, 5362.2224777407055, 5362.51737343641, 5385.9730701347025, 3148.5906832112137, 3202.8398580070902, 3223.7259832914465, 3237.3848968695875, 3246.7077962983444, 5886.529077673776, 5896.823095307148, 5912.3496415394275, 5950.9107363389585, 6006.819795406145, 5970.134330522137, 5977.820665379959, 5985.25184351956, 5999.100134979701, 6011.398860113954, 5791.044477661223, 5895.498882595028, 5906.940930590725, 5937.584369094122, 5961.135635332939, 5837.211976383134, 5848.64908105515, 5919.7040147991565, 5922.082077278029, 5962.612430192024, 5621.578381621313, 5697.4302569742695, 5708.65748055118, 5770.365259821332, 5797.159411885337, 5936.0, 5943.970280148572, 5980.5215582754145, 5983.581149319506, 6015.0, 3890.8054597269456, 3928.489296391451, 3930.2139572085125, 3943.546492153439, 3954.268460334847, 5763.193152958673, 5766.221560089502, 5886.087656413263, 5898.469137777621, 5910.52715782745, 5751.511121554715, 5765.423457654201, 5777.133429985536, 5788.102844059177, 5797.79707710245, 5711.485966263056, 5720.542356611378, 5727.455891690282, 5728.942710572841, 5768.163616275533, 5436.456354364532, 5627.943720562906, 5644.858878527905, 5646.983542962306, 5652.123920792284, 5682.914756278742, 5688.11834165705, 5689.118186681071, 5699.202111704281, 5722.141678748221, 5568.77724891016, 5608.383077861514, 5616.0, 5633.126865335879, 5662.518685911744], "yui.html": [684.2712511175598, 689.9413549848263, 696.4706822814662, 710.2826145592951, 749.2657195947968, 11414.71463213419, 11607.245529040607, 11620.709482262937, 11625.47685354159, 11665.70835729105, 10686.788109695608, 11164.832527512073, 11308.830367544493, 11310.717232069203, 11374.260673056246, 635.5773410681891, 647.1489990662287, 785.2579312549643, 801.1187693537091, 808.1716240853114, 765.2156539546982, 791.8060075281564, 811.8741595052746, 812.2689579378548, 813.446856137826, 837.3217693668117, 838.995805020974, 842.5576572299561, 847.3179090831878, 858.3390789092396, 656.0389030070945, 661.6757788683559, 834.4951304460775, 849.7153453593054, 859.0807835615893, 617.9073139029136, 620.5159975219336, 621.9657918814463, 627.6328347916474, 630.3192552043781, 11267.21129520934, 11357.886421135765, 11449.828252576219, 11464.0, 11478.196526243166, 9578.521073946275, 9645.08371704687, 10079.143272821819, 10243.897561024369, 10303.3817970922, 7715.884261736079, 7836.647350869168, 7913.525188488651, 7943.126256111823, 7999.400044996591, 2882.6252587163535, 2976.583278341034, 2981.6720160782297, 3019.230096325423, 3046.466868298061, 34144.658553414396, 34495.31009379798, 34549.309013819584, 35150.64849351499, 36671.81664091689, 7273.818154546073, 7445.590492522963, 7629.3133617974645, 7681.692732290758, 7821.765347039598, 16131.112788796494, 16175.0, 16180.271887765079, 16212.270447829877, 16216.83783162177, 5913.970430147908, 5962.105684147413, 5966.19456373384, 6113.144159817629, 6140.2017737694705, 3232.2727386338356, 3297.2242042602684, 3298.1733729193747, 3303.240254741423, 3312.5528053712924, 2687.422204226101, 2699.1767510908967, 2707.7969152313262, 2720.9047683330987, 2724.7002829688718, 379.97340186187256, 381.2717709175462, 384.88838236911545, 386.25452875949685, 386.52650503133435, 456.0878243512974, 477.29122253453596, 505.14882423117166, 560.403170623285, 560.4087687489738, 6837.35045170708, 6885.414739747077, 7016.92983070173, 7043.0, 7082.0, 449.6313023320911, 509.2564855311213, 535.2800483349888, 549.8240563019875, 569.487461284847, 3328.2012317043736, 3377.4427219508507, 3434.1586311353876, 3477.3566890125408, 3586.7309951753723, 41804.58195418068, 41821.0, 42397.788011060366, 42455.0, 42625.0, 34387.656123438945, 34703.479447808306, 35056.82471587677, 35873.64126358703, 36466.08834779152, 29935.0, 30466.390672186433, 30556.541651875683, 32006.35987280288, 32620.836895815843, 6748.122744043243, 6897.7240910365035, 7031.879845925543, 7052.435805135679, 7227.530210536509, 22419.77580224177, 22976.655350169425, 23061.65407518922, 23071.769282306963, 23268.418289542897, 29834.254143645714, 29927.401451970403, 30134.397312054076, 30174.84912575423, 30274.84862575673, 6009.0, 6224.9377506224355, 6396.744130234924, 6417.550771445954, 6602.273749887605, 9088.454692718458, 9213.769655758391, 9271.98008219082, 9322.720318390458, 9370.34407591462, 8752.984426041188, 8793.164649358301, 9115.863262050942, 9265.351425400428, 9376.859347109663, 8587.742367728979, 8718.8523529354, 8954.597043133204, 8974.56406974907, 9107.590158442754, 8654.567271636268, 8708.216260536583, 8929.151730585583, 8960.775980600538, 9194.58624361892, 7690.8511062388325, 7714.267144621252, 7889.802754931173, 7912.802179945547, 7972.402069844901, 7198.6040767756185, 7636.389088872766, 7717.112532058885, 7969.6015199240965, 7982.241687039722]}, "summary": {"suite": 6047.4716678671375, "subtests": {"jquery.html": {"filtered": 5959.97453762131, "value": 5959.97453762131}, "dojo.html": {"filtered": 4992.796323853125, "value": 4992.796323853125}, "mootools.html": {"filtered": 4576.483761787561, "value": 4576.483761787561}, "ext.html": {"filtered": 16503.360496363483, "value": 16503.360496363483}, "prototype.html": {"filtered": 4321.15679131315, "value": 4321.15679131315}, "yui.html": {"filtered": 5036.322789145794, "value": 5036.322789145794}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1445476406, "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.0a1", "id": "20151021162101", "branch": "Firefox", "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 179.0, 177.0, 175.0, 172.0, 178.0, 180.0, 180.0, 210.0, 188.0], "ai-astar": [111.0, 116.0, 108.0, 112.0, 115.0, 113.0, 114.0, 116.0, 110.0, 114.0], "imaging-gaussian-blur": [133.0, 130.0, 130.0, 141.0, 132.0, 137.0, 135.0, 135.0, 129.0, 136.0], "audio-beat-detection": [155.0, 155.0, 167.0, 179.0, 161.0, 157.0, 161.0, 158.0, 181.0, 157.0], "json-stringify-tinderbox": [66.0, 68.0, 71.0, 72.0, 71.0, 72.0, 71.0, 71.0, 71.0, 71.0], "stanford-crypto-pbkdf2": [162.0, 166.0, 165.0, 166.0, 170.0, 168.0, 168.0, 166.0, 167.0, 155.0], "json-parse-financial": [63.0, 63.0, 65.0, 65.0, 66.0, 66.0, 65.0, 75.0, 65.0, 64.0], "stanford-crypto-sha256-iterative": [78.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0, 80.0, 80.0, 81.0], "audio-fft": [84.0, 88.0, 91.0, 109.0, 93.0, 91.0, 90.0, 89.0, 99.0, 89.0], "imaging-darkroom": [142.0, 141.0, 141.0, 141.0, 141.0, 141.0, 141.0, 141.0, 141.0, 141.0], "stanford-crypto-ccm": [138.0, 149.0, 146.0, 141.0, 148.0, 140.0, 146.0, 149.0, 152.0, 136.0], "audio-oscillator": [109.0, 116.0, 151.0, 115.0, 116.0, 117.0, 151.0, 116.0, 117.0, 159.0], "stanford-crypto-aes": [90.0, 95.0, 95.0, 96.0, 97.0, 100.0, 96.0, 97.0, 97.0, 95.0], "imaging-desaturate": [114.0, 113.0, 117.0, 118.0, 114.0, 115.0, 112.0, 119.0, 117.0, 113.0]}, "summary": {"suite": 1688.7, "subtests": {"audio-fft": {"filtered": 92.3, "value": 92.3}, "stanford-crypto-pbkdf2": {"filtered": 165.3, "value": 165.3}, "audio-beat-detection": {"filtered": 163.1, "value": 163.1}, "stanford-crypto-ccm": {"filtered": 144.5, "value": 144.5}, "imaging-darkroom": {"filtered": 141.1, "value": 141.1}, "json-parse-financial": {"filtered": 65.7, "value": 65.7}, "audio-oscillator": {"filtered": 126.7, "value": 126.7}, "ai-astar": {"filtered": 112.9, "value": 112.9}, "audio-dft": {"filtered": 181.1, "value": 181.1}, "stanford-crypto-sha256-iterative": {"filtered": 80.8, "value": 80.8}, "json-stringify-tinderbox": {"filtered": 70.4, "value": 70.4}, "imaging-gaussian-blur": {"filtered": 133.8, "value": 133.8}, "stanford-crypto-aes": {"filtered": 95.8, "value": 95.8}, "imaging-desaturate": {"filtered": 115.2, "value": 115.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1445476406, "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.0a1", "id": "20151021162101", "branch": "Firefox", "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [231.5886984715146], "Encrypt": [349.8950314905528], "NavierStokes": [6407.643312101911], "Decrypt": [6629.139072847682], "Splay": [833.3333333333334], "Richards": [175.07002801120447], "RegExp": [33377.04918032787], "Earley": [1003.0090270812437], "Boyer": [14126.760563380281], "RayTrace": [2293.577981651376]}, "summary": {"suite": 16077.44629689797, "subtests": {"DeltaBlue": {"filtered": 285.49752399999994, "value": 285.49752399999994}, "Encrypt": {"filtered": 760.745298, "value": 760.745298}, "NavierStokes": {"filtered": 231.5984095427434, "value": 231.5984095427434}, "Decrypt": {"filtered": 40.15317782217779, "value": 40.15317782217779}, "Splay": {"filtered": 97.78920000000001, "value": 97.78920000000001}, "RegExp": {"filtered": 27.29375491159136, "value": 27.29375491159136}, "Richards": {"filtered": 201.645024, "value": 201.645024}, "Earley": {"filtered": 664.4636109999998, "value": 664.4636109999998}, "Boyer": {"filtered": 47.17734097706878, "value": 47.17734097706878}, "RayTrace": {"filtered": 322.635204, "value": 322.635204}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1445476406, "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.0a1", "id": "20151021162101", "branch": "Firefox", "revision": "f029ccdee154bdc2b49a1e0fcd5b0fa0397aa97b"}}] 18:33:42 INFO - RETURN: dromaeo_css: 6047.47 18:33:42 INFO - RETURN: kraken: 1688.70 18:33:42 INFO - RETURN: v8_7: 16077.45 18:33:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16077.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1688.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6047.47"}}} 18:33:42 INFO - Return code: 0 18:33:42 INFO - # TBPL SUCCESS # 18:33:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:33:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:33:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:33:42 INFO - 2015-10-21 18:33:42.562 screenresolution[1654:9746] starting screenresolution argv=screenresolution get 18:33:42 INFO - 2015-10-21 18:33:42.565 screenresolution[1654:9746] Display 0: 1600x1200x32@60 18:33:42 INFO - 2015-10-21 18:33:42.571 screenresolution[1655:9749] starting screenresolution argv=screenresolution list 18:33:42 INFO - Available Modes on Display 0 18:33:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:33:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:33:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:33:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:33:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:33:42 INFO - Intel HD Graphics 3000: 18:33:42 INFO - Chipset Model: Intel HD Graphics 3000 18:33:42 INFO - Type: GPU 18:33:42 INFO - Bus: Built-In 18:33:42 INFO - VRAM (Total): 512 MB 18:33:42 INFO - VRAM (Dynamic, Max): 10 18:33:42 INFO - Vendor: Intel (0x8086) 18:33:42 INFO - Device ID: 0x0116 18:33:42 INFO - Revision ID: 0x0009 18:33:42 INFO - Displays: 18:33:42 INFO - Display: 18:33:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:33:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:33:42 INFO - Display Serial Number: 1600x1200 60 18:33:42 INFO - Main Display: Yes 18:33:42 INFO - Mirror: Off 18:33:42 INFO - Online: Yes 18:33:42 INFO - Rotation: Supported 18:33:42 INFO - Return code: 0 18:33:42 INFO - Running post-action listener: _resource_record_post_action 18:33:42 INFO - Running post-run listener: _resource_record_post_run 18:33:43 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 38597632; Write bytes: 704342016; Read time: 4506; Write time: 54242 18:33:43 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 344107520; Write bytes: 346228736; Read time: 35256; Write time: 6668 18:33:43 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 36545536; Write bytes: 356290560; Read time: 3999; Write time: 47556 18:33:43 INFO - Running post-run listener: _upload_blobber_files 18:33:43 INFO - Blob upload gear active. 18:33:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:33:43 INFO - Copying logs to upload dir... 18:33:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1346.900108 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-10-21 18:33:43.996098) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 18:33:43.999805) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010086 build_url: 'https://queue.taskcluster.net/v1/task/2_fUD6muTZmPFXycmi3naQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 18:33:44.025414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:33:44.025718) ========= 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.4N5xESgqQd/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.fD2CwApoFr/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/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.005424 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 18:33:44.080577) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-21 18:33:44.080885) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-21 18:33:45.787941) =========