builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0026 starttime: 1447715607.62 results: success (0) buildid: 20151116135636 builduid: 2e8c2041fc4a4cc0ad665b954bfe46b7 revision: 6f40e9b622236da96a2c10e57b95118acc85ecd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.615485) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.615957) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.616243) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.006187 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.928416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.928822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.957186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:27.957519) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.012054 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.006734) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.007036) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.007435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.007778) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 15:13:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.12M=0.001s 2015-11-16 15:13:28 (9.12 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.178550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.178871) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.100739 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.294544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.294954) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6f40e9b622236da96a2c10e57b95118acc85ecd4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6f40e9b622236da96a2c10e57b95118acc85ecd4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 15:13:28,379 truncating revision to first 12 chars 2015-11-16 15:13:28,379 Setting DEBUG logging. 2015-11-16 15:13:28,380 attempt 1/10 2015-11-16 15:13:28,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6f40e9b62223?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 15:13:28,625 unpacking tar archive at: mozilla-inbound-6f40e9b62223/testing/mozharness/ program finished with exit code 0 elapsedTime=0.512701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.823623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.824086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.837041) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.837408) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 15:13:28.837832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-16 15:13:28.838120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:13:29 INFO - MultiFileLogger online at 20151116 15:13:29 in /builds/slave/test 15:13:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:13:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:29 INFO - {'append_to_log': False, 15:13:29 INFO - 'base_work_dir': '/builds/slave/test', 15:13:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:13:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:29 INFO - 'branch': 'Mozilla-Inbound', 15:13:29 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:29 INFO - 'config_files': ('talos/mac_config.py',), 15:13:29 INFO - 'default_actions': ('clobber', 15:13:29 INFO - 'read-buildbot-config', 15:13:29 INFO - 'download-and-extract', 15:13:29 INFO - 'populate-webroot', 15:13:29 INFO - 'create-virtualenv', 15:13:29 INFO - 'install', 15:13:29 INFO - 'run-tests'), 15:13:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:29 INFO - 'download_minidump_stackwalk': True, 15:13:29 INFO - 'download_symbols': 'ondemand', 15:13:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:29 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:29 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:29 INFO - 'installer_path': 'installer.exe', 15:13:29 INFO - 'log_level': 'info', 15:13:29 INFO - 'log_name': 'talos', 15:13:29 INFO - 'log_to_console': True, 15:13:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:13:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:13:29 INFO - 'opt_config_files': (), 15:13:29 INFO - 'pip_index': False, 15:13:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:13:29 INFO - 'cmd': ('bash', 15:13:29 INFO - '-c', 15:13:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:13:29 INFO - 'enabled': True, 15:13:29 INFO - 'halt_on_failure': False, 15:13:29 INFO - 'name': 'check_screen_resolution'},), 15:13:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:13:29 INFO - 'cmd': ('bash', 15:13:29 INFO - '-c', 15:13:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:13:29 INFO - 'enabled': True, 15:13:29 INFO - 'halt_on_failure': False, 15:13:29 INFO - 'name': 'check_screen_resolution'},), 15:13:29 INFO - 'run_cmd_checks_enabled': True, 15:13:29 INFO - 'sps_profile': False, 15:13:29 INFO - 'sps_profile_interval': 0, 15:13:29 INFO - 'suite': 'dromaeojs-e10s', 15:13:29 INFO - 'system_bits': '64', 15:13:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:29 INFO - 'title': 't-yosemite-r5-0026', 15:13:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:29 INFO - 'use_talos_json': True, 15:13:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:29 INFO - 'work_dir': 'build'} 15:13:29 INFO - ##### 15:13:29 INFO - ##### Running clobber step. 15:13:29 INFO - ##### 15:13:29 INFO - Running pre-action listener: _resource_record_pre_action 15:13:29 INFO - Running main action method: clobber 15:13:29 INFO - rmtree: /builds/slave/test/build 15:13:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:33 INFO - Running post-action listener: _resource_record_post_action 15:13:33 INFO - ##### 15:13:33 INFO - ##### Running read-buildbot-config step. 15:13:33 INFO - ##### 15:13:33 INFO - Running pre-action listener: _resource_record_pre_action 15:13:33 INFO - Running main action method: read_buildbot_config 15:13:33 INFO - Using buildbot properties: 15:13:33 INFO - { 15:13:33 INFO - "properties": { 15:13:33 INFO - "buildnumber": 185, 15:13:33 INFO - "product": "firefox", 15:13:33 INFO - "script_repo_revision": "production", 15:13:33 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 15:13:33 INFO - "repository": "", 15:13:33 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 15:13:33 INFO - "buildid": "20151116135636", 15:13:33 INFO - "slavename": "t-yosemite-r5-0026", 15:13:33 INFO - "pgo_build": "False", 15:13:33 INFO - "basedir": "/builds/slave/test", 15:13:33 INFO - "project": "", 15:13:33 INFO - "platform": "yosemite", 15:13:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:13:33 INFO - "slavebuilddir": "test", 15:13:33 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 15:13:33 INFO - "branch": "mozilla-inbound", 15:13:33 INFO - "repo_path": "integration/mozilla-inbound", 15:13:33 INFO - "stage_platform": "macosx64", 15:13:33 INFO - "builduid": "2e8c2041fc4a4cc0ad665b954bfe46b7", 15:13:33 INFO - "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4" 15:13:33 INFO - }, 15:13:33 INFO - "sourcestamp": { 15:13:33 INFO - "repository": "", 15:13:33 INFO - "hasPatch": false, 15:13:33 INFO - "project": "", 15:13:33 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:13:33 INFO - "changes": [ 15:13:33 INFO - { 15:13:33 INFO - "category": null, 15:13:33 INFO - "files": [ 15:13:33 INFO - { 15:13:33 INFO - "url": null, 15:13:33 INFO - "name": "https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:13:33 INFO - } 15:13:33 INFO - ], 15:13:33 INFO - "repository": "", 15:13:33 INFO - "rev": "6f40e9b622236da96a2c10e57b95118acc85ecd4", 15:13:33 INFO - "who": "blassey@mozilla.com", 15:13:33 INFO - "when": 1447715587, 15:13:33 INFO - "number": 6668628, 15:13:33 INFO - "comments": "bug 1190018 - External protocol handlers don't work in e10s r=mrbkap", 15:13:33 INFO - "project": "", 15:13:33 INFO - "at": "Mon 16 Nov 2015 15:13:07", 15:13:33 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:13:33 INFO - "revlink": "", 15:13:33 INFO - "properties": [ 15:13:33 INFO - [ 15:13:33 INFO - "buildid", 15:13:33 INFO - "20151116135636", 15:13:33 INFO - "Change" 15:13:33 INFO - ], 15:13:33 INFO - [ 15:13:33 INFO - "builduid", 15:13:33 INFO - "2e8c2041fc4a4cc0ad665b954bfe46b7", 15:13:33 INFO - "Change" 15:13:33 INFO - ], 15:13:33 INFO - [ 15:13:33 INFO - "pgo_build", 15:13:33 INFO - "False", 15:13:33 INFO - "Change" 15:13:33 INFO - ] 15:13:33 INFO - ], 15:13:33 INFO - "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4" 15:13:33 INFO - } 15:13:33 INFO - ], 15:13:33 INFO - "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4" 15:13:33 INFO - } 15:13:33 INFO - } 15:13:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:13:33 INFO - Running post-action listener: _resource_record_post_action 15:13:33 INFO - ##### 15:13:33 INFO - ##### Running download-and-extract step. 15:13:33 INFO - ##### 15:13:33 INFO - Running pre-action listener: _resource_record_pre_action 15:13:33 INFO - Running main action method: download_and_extract 15:13:33 INFO - mkdir: /builds/slave/test/build/tests 15:13: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')]} 15:13:33 INFO - https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/test_packages.json 15:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/test_packages.json 15:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:13:34 INFO - Downloaded 1149 bytes. 15:13:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:13:34 INFO - Using the following test package requirements: 15:13:34 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:13:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:13:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'jsshell-mac.zip'], 15:13:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:13:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:13:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:13:34 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:13:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:13:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:13:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:13:34 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:13:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:13:34 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')]} 15:13:34 INFO - https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:13:36 INFO - Downloaded 17464051 bytes. 15:13:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 15:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:13:40 INFO - Return code: 0 15:13:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:13: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')]} 15:13:40 INFO - https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:13:43 INFO - Downloaded 17464051 bytes. 15:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 15:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:13:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:13:49 INFO - Return code: 0 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:49 INFO - https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:13:50 INFO - Downloaded 11131693 bytes. 15:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 15:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:13:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:13:51 INFO - Return code: 0 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 INFO - https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 15:13:55 INFO - Downloaded 108695346 bytes. 15:13:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:13:55 INFO - mkdir: /builds/slave/test/properties 15:13:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:55 INFO - Contents: 15:13:55 INFO - build_url:https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:13:55 INFO - Running post-action listener: _resource_record_post_action 15:13:55 INFO - Running post-action listener: set_extra_try_arguments 15:13:55 INFO - ##### 15:13:55 INFO - ##### Running populate-webroot step. 15:13:55 INFO - ##### 15:13:55 INFO - Running pre-action listener: _resource_record_pre_action 15:13:55 INFO - Running main action method: populate_webroot 15:13:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:13:55 INFO - '../fennec_ids.txt'], 15:13:55 INFO - 'tests': ['tcheck2']}, 15:13:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:55 INFO - '--tppagecycles', 15:13:55 INFO - '7'], 15:13:55 INFO - 'tests': ['tsvgm']}}, 15:13:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:13:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'tests': ['damp', 'tps']}, 15:13:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['damp', 'tps']}, 15:13:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:13:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:55 INFO - 'other': {'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'other_l64': {'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'other_nol64': {'tests': ['a11yr', 15:13:55 INFO - 'ts_paint', 15:13:55 INFO - 'tpaint', 15:13:55 INFO - 'sessionrestore', 15:13:55 INFO - 'sessionrestore_no_auto_restore']}, 15:13:55 INFO - 'svgr': {'tests': ['tsvgx', 15:13:55 INFO - 'tsvgr_opacity', 15:13:55 INFO - 'tart', 15:13:55 INFO - 'tscrollx', 15:13:55 INFO - 'cart']}, 15:13:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['tsvgx', 15:13:55 INFO - 'tsvgr_opacity', 15:13:55 INFO - 'tart', 15:13:55 INFO - 'tscrollx', 15:13:55 INFO - 'cart']}, 15:13:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'tests': ['tp5o']}, 15:13:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'talos_options': ['--e10s'], 15:13:55 INFO - 'tests': ['tp5o']}, 15:13:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'talos_options': ['--xperf_path', 15:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:55 INFO - 'tests': ['tp5n']}, 15:13:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:55 INFO - 'talos_options': ['--e10s', 15:13:55 INFO - '--xperf_path', 15:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:55 INFO - 'tests': ['tp5n']}}, 15:13:55 INFO - 'talos.zip': {'path': '', 15:13:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:55 INFO - Running post-action listener: _resource_record_post_action 15:13:55 INFO - ##### 15:13:55 INFO - ##### Running create-virtualenv step. 15:13:55 INFO - ##### 15:13:55 INFO - Running pre-action listener: _resource_record_pre_action 15:13:55 INFO - Running main action method: create_virtualenv 15:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:55 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 15:13:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:55 INFO - Using real prefix '/tools/python27' 15:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:56 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:00 INFO - Installing pip.................done. 15:14:00 INFO - Return code: 0 15:14:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14:00 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')]} 15:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 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')]} 15:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:00 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 15:14:00 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 15:14:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:00 INFO - 'HOME': '/Users/cltbld', 15:14:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:00 INFO - 'LOGNAME': 'cltbld', 15:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:00 INFO - 'MOZ_NO_REMOTE': '1', 15:14:00 INFO - 'NO_EM_RESTART': '1', 15:14:00 INFO - 'PAGER': '/bin/cat', 15:14:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:00 INFO - 'PWD': '/builds/slave/test', 15:14:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:00 INFO - 'SHELL': '/bin/bash', 15:14:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:00 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:00 INFO - 'USER': 'cltbld', 15:14:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:00 INFO - 'XPC_FLAGS': '0x0', 15:14:00 INFO - 'XPC_SERVICE_NAME': '0', 15:14:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:01 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 15:14:01 INFO - Cleaning up... 15:14:01 INFO - Return code: 0 15:14:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:14:01 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')]} 15:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:01 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')]} 15:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:01 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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:01 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 15:14:01 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 15:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:01 INFO - 'HOME': '/Users/cltbld', 15:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:01 INFO - 'LOGNAME': 'cltbld', 15:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:01 INFO - 'MOZ_NO_REMOTE': '1', 15:14:01 INFO - 'NO_EM_RESTART': '1', 15:14:01 INFO - 'PAGER': '/bin/cat', 15:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:01 INFO - 'PWD': '/builds/slave/test', 15:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:01 INFO - 'SHELL': '/bin/bash', 15:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:01 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:01 INFO - 'USER': 'cltbld', 15:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:01 INFO - 'XPC_FLAGS': '0x0', 15:14:01 INFO - 'XPC_SERVICE_NAME': '0', 15:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:01 INFO - Downloading/unpacking psutil>=0.7.1 15:14:01 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 15:14:01 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 15:14:01 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 15:14:01 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 15:14:01 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 15:14:01 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 15:14:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:14:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:04 INFO - Installing collected packages: psutil 15:14:04 INFO - Running setup.py install for psutil 15:14:04 INFO - building 'psutil._psutil_osx' extension 15:14:04 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 15:14:06 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 15:14:06 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 15:14:06 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 15:14:06 INFO - building 'psutil._psutil_posix' extension 15:14:06 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 15:14:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:14:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:14:06 INFO - ^ 15:14:06 INFO - 1 warning generated. 15:14:06 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 15:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:07 INFO - Successfully installed psutil 15:14:07 INFO - Cleaning up... 15:14:07 INFO - Return code: 0 15:14:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:07 INFO - 'HOME': '/Users/cltbld', 15:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:07 INFO - 'LOGNAME': 'cltbld', 15:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:07 INFO - 'MOZ_NO_REMOTE': '1', 15:14:07 INFO - 'NO_EM_RESTART': '1', 15:14:07 INFO - 'PAGER': '/bin/cat', 15:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:07 INFO - 'PWD': '/builds/slave/test', 15:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:07 INFO - 'SHELL': '/bin/bash', 15:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:07 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:07 INFO - 'USER': 'cltbld', 15:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:07 INFO - 'XPC_FLAGS': '0x0', 15:14:07 INFO - 'XPC_SERVICE_NAME': '0', 15:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:14:10 INFO - Installing collected packages: mozsystemmonitor 15:14:10 INFO - Running setup.py install for mozsystemmonitor 15:14:10 INFO - Successfully installed mozsystemmonitor 15:14:10 INFO - Cleaning up... 15:14:10 INFO - Return code: 0 15:14:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:10 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 15:14:10 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 15:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:10 INFO - 'HOME': '/Users/cltbld', 15:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:10 INFO - 'LOGNAME': 'cltbld', 15:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:10 INFO - 'MOZ_NO_REMOTE': '1', 15:14:10 INFO - 'NO_EM_RESTART': '1', 15:14:10 INFO - 'PAGER': '/bin/cat', 15:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:10 INFO - 'PWD': '/builds/slave/test', 15:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:10 INFO - 'SHELL': '/bin/bash', 15:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:10 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:10 INFO - 'USER': 'cltbld', 15:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:10 INFO - 'XPC_FLAGS': '0x0', 15:14:10 INFO - 'XPC_SERVICE_NAME': '0', 15:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:14:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:14:13 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 15:14:13 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 15:14:13 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 15:14:13 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 15:14:13 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 15:14:13 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 15:14:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:14:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:14 INFO - Downloading docopt-0.6.1.tar.gz 15:14:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:14:14 INFO - Running setup.py install for blobuploader 15:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:14:14 INFO - Running setup.py install for requests 15:14:15 INFO - Running setup.py install for docopt 15:14:15 INFO - Successfully installed blobuploader requests docopt 15:14:15 INFO - Cleaning up... 15:14:15 INFO - Return code: 0 15:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:15 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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:15 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 15:14:15 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 15:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:15 INFO - 'HOME': '/Users/cltbld', 15:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:15 INFO - 'LOGNAME': 'cltbld', 15:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:15 INFO - 'MOZ_NO_REMOTE': '1', 15:14:15 INFO - 'NO_EM_RESTART': '1', 15:14:15 INFO - 'PAGER': '/bin/cat', 15:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:15 INFO - 'PWD': '/builds/slave/test', 15:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:15 INFO - 'SHELL': '/bin/bash', 15:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:15 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:15 INFO - 'USER': 'cltbld', 15:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:15 INFO - 'XPC_FLAGS': '0x0', 15:14:15 INFO - 'XPC_SERVICE_NAME': '0', 15:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-3Jhkta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-WQl4cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Q9ppjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-4ebAJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-hU7te3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-w5vS18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:16 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-V49Mlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-hXg7Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-AHz3_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ymsP91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-tRCCws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-3t78ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-OxgJx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-RdyWLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:17 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-P08Iz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-5i5aje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-kc8WSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:18 INFO - Running setup.py install for manifestparser 15:14:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:18 INFO - Running setup.py install for mozcrash 15:14:18 INFO - Running setup.py install for mozdebug 15:14:18 INFO - Running setup.py install for mozdevice 15:14:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Running setup.py install for mozfile 15:14:19 INFO - Running setup.py install for mozhttpd 15:14:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Running setup.py install for mozinfo 15:14:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Running setup.py install for mozInstall 15:14:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:19 INFO - Running setup.py install for mozleak 15:14:20 INFO - Running setup.py install for mozlog 15:14:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:20 INFO - Running setup.py install for moznetwork 15:14:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:20 INFO - Running setup.py install for mozprocess 15:14:20 INFO - Running setup.py install for mozprofile 15:14:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:20 INFO - Running setup.py install for mozrunner 15:14:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:21 INFO - Running setup.py install for mozscreenshot 15:14:21 INFO - Running setup.py install for moztest 15:14:21 INFO - Running setup.py install for mozversion 15:14:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:21 INFO - Cleaning up... 15:14:21 INFO - Return code: 0 15:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:21 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 15:14:21 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 15:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:21 INFO - 'HOME': '/Users/cltbld', 15:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:21 INFO - 'LOGNAME': 'cltbld', 15:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:21 INFO - 'MOZ_NO_REMOTE': '1', 15:14:21 INFO - 'NO_EM_RESTART': '1', 15:14:21 INFO - 'PAGER': '/bin/cat', 15:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:21 INFO - 'PWD': '/builds/slave/test', 15:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:21 INFO - 'SHELL': '/bin/bash', 15:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:21 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:21 INFO - 'USER': 'cltbld', 15:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:21 INFO - 'XPC_FLAGS': '0x0', 15:14:21 INFO - 'XPC_SERVICE_NAME': '0', 15:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-YTIDPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:22 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)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-9dPSAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:22 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)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-aa8N4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:22 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)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-C5Z1cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Sg_6Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:22 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)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-_Q1W0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:22 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)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-j9QRHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:22 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-6ytkj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-KNC0ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-GRGBSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-rTwaJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-eRS0LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-qhsnKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:23 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)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-erEymf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:23 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-m36RmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:24 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)) 15:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:24 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-mXOH5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:24 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)) 15:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:24 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-anA77I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:24 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)) 15:14:24 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)) 15:14:24 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)) 15:14:24 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)) 15:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:24 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 15:14:24 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 15:14:24 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 15:14:24 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 15:14:24 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 15:14:24 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 15:14:26 INFO - Downloading blessings-1.5.1.tar.gz 15:14:26 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 15:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:26 INFO - Installing collected packages: blessings 15:14:26 INFO - Running setup.py install for blessings 15:14:27 INFO - Successfully installed blessings 15:14:27 INFO - Cleaning up... 15:14:27 INFO - Return code: 0 15:14:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:27 INFO - Reading from file tmpfile_stdout 15:14:27 INFO - Current package versions: 15:14:27 INFO - blessings == 1.5.1 15:14:27 INFO - blobuploader == 1.2.4 15:14:27 INFO - docopt == 0.6.1 15:14:27 INFO - manifestparser == 1.1 15:14:27 INFO - mozInstall == 1.12 15:14:27 INFO - mozcrash == 0.16 15:14:27 INFO - mozdebug == 0.1 15:14:27 INFO - mozdevice == 0.47 15:14:27 INFO - mozfile == 1.2 15:14:27 INFO - mozhttpd == 0.7 15:14:27 INFO - mozinfo == 0.9 15:14:27 INFO - mozleak == 0.1 15:14:27 INFO - mozlog == 3.0 15:14:27 INFO - moznetwork == 0.27 15:14:27 INFO - mozprocess == 0.22 15:14:27 INFO - mozprofile == 0.27 15:14:27 INFO - mozrunner == 6.11 15:14:27 INFO - mozscreenshot == 0.1 15:14:27 INFO - mozsystemmonitor == 0.0 15:14:27 INFO - moztest == 0.7 15:14:27 INFO - mozversion == 1.4 15:14:27 INFO - psutil == 3.1.1 15:14:27 INFO - requests == 1.2.3 15:14:27 INFO - wsgiref == 0.1.2 15:14:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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')]} 15:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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', '-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 0x10ef60490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb929701b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, '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.WrAFzflvdO/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.uJTknfjb8z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 15:14:27 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 15:14:27 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 15:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:27 INFO - 'HOME': '/Users/cltbld', 15:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:27 INFO - 'LOGNAME': 'cltbld', 15:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:27 INFO - 'MOZ_NO_REMOTE': '1', 15:14:27 INFO - 'NO_EM_RESTART': '1', 15:14:27 INFO - 'PAGER': '/bin/cat', 15:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:27 INFO - 'PWD': '/builds/slave/test', 15:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:27 INFO - 'SHELL': '/bin/bash', 15:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:14:27 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:27 INFO - 'USER': 'cltbld', 15:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:27 INFO - 'XPC_FLAGS': '0x0', 15:14:27 INFO - 'XPC_SERVICE_NAME': '0', 15:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 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)) 15:14:27 INFO - Cleaning up... 15:14:27 INFO - Return code: 0 15:14:27 INFO - Running post-action listener: _resource_record_post_action 15:14:27 INFO - Running post-action listener: _start_resource_monitoring 15:14:27 INFO - Starting resource monitoring. 15:14:27 INFO - ##### 15:14:27 INFO - ##### Running install step. 15:14:27 INFO - ##### 15:14:27 INFO - Running pre-action listener: _resource_record_pre_action 15:14:27 INFO - Running main action method: install 15:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:28 INFO - Reading from file tmpfile_stdout 15:14:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:28 INFO - Reading from file tmpfile_stdout 15:14:28 INFO - Output received: 15:14:28 INFO - Usage: mozinstall [options] installer 15:14:28 INFO - Options: 15:14:28 INFO - -h, --help show this help message and exit 15:14:28 INFO - -d DEST, --destination=DEST 15:14:28 INFO - Directory to install application into. [default: 15:14:28 INFO - "/builds/slave/test"] 15:14:28 INFO - --app=APP Application being installed. [default: firefox] 15:14:28 INFO - mkdir: /builds/slave/test/build/application 15:14:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:15:08 INFO - Reading from file tmpfile_stdout 15:15:08 INFO - Output received: 15:15:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:15:08 INFO - Running post-action listener: _resource_record_post_action 15:15:08 INFO - ##### 15:15:08 INFO - ##### Running run-tests step. 15:15:08 INFO - ##### 15:15:08 INFO - Running pre-action listener: _resource_record_pre_action 15:15:08 INFO - Running main action method: run_tests 15:15:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:15:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:15:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:15:08 INFO - 2015-11-16 15:15:08.514 screenresolution[1632:7737] starting screenresolution argv=screenresolution get 15:15:08 INFO - 2015-11-16 15:15:08.518 screenresolution[1632:7737] Display 0: 1600x1200x32@60 15:15:08 INFO - 2015-11-16 15:15:08.525 screenresolution[1633:7739] starting screenresolution argv=screenresolution list 15:15:08 INFO - Available Modes on Display 0 15:15:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:15:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:15:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:15:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:15:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:15:08 INFO - Intel HD Graphics 3000: 15:15:08 INFO - Chipset Model: Intel HD Graphics 3000 15:15:08 INFO - Type: GPU 15:15:08 INFO - Bus: Built-In 15:15:08 INFO - VRAM (Total): 512 MB 15:15:08 INFO - VRAM (Dynamic, Max): 10 15:15:08 INFO - Vendor: Intel (0x8086) 15:15:08 INFO - Device ID: 0x0116 15:15:08 INFO - Revision ID: 0x0009 15:15:08 INFO - Displays: 15:15:08 INFO - Display: 15:15:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:15:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:15:08 INFO - Display Serial Number: 1600x1200 60 15:15:08 INFO - Main Display: Yes 15:15:08 INFO - Mirror: Off 15:15:08 INFO - Online: Yes 15:15:08 INFO - Rotation: Supported 15:15:08 INFO - Return code: 0 15:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:08 INFO - Python 2.7.3 15:15:08 INFO - Return code: 0 15:15:08 INFO - grabbing minidump binary from tooltool 15:15:08 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')]} 15:15:08 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 0x10ee839f0>, '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 0x10ebe3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee778c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:08 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 15:15:08 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 15:15:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:08 INFO - Return code: 0 15:15:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:15:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] in /builds/slave/test/build 15:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0026 --webServer localhost 15:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAFzflvdO/Render', 15:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:08 INFO - 'HOME': '/Users/cltbld', 15:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:08 INFO - 'LOGNAME': 'cltbld', 15:15:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:08 INFO - 'MOZ_NO_REMOTE': '1', 15:15:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:08 INFO - 'NO_EM_RESTART': '1', 15:15:08 INFO - 'PAGER': '/bin/cat', 15:15:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:08 INFO - 'PWD': '/builds/slave/test', 15:15:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:08 INFO - 'SHELL': '/bin/bash', 15:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uJTknfjb8z/Listeners', 15:15:08 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 15:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:08 INFO - 'USER': 'cltbld', 15:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:08 INFO - 'XPC_FLAGS': '0x0', 15:15:08 INFO - 'XPC_SERVICE_NAME': '0', 15:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:15:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] with output_timeout 3600 15:15:09 INFO - mozversion INFO | application_buildid: 20151116135636 15:15:09 INFO - mozversion INFO | application_changeset: 6f40e9b622236da96a2c10e57b95118acc85ecd4 15:15:09 INFO - mozversion INFO | application_display_name: Nightly 15:15:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:09 INFO - mozversion INFO | application_name: Firefox 15:15:09 INFO - mozversion INFO | application_remotingname: firefox 15:15:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:15:09 INFO - mozversion INFO | application_vendor: Mozilla 15:15:09 INFO - mozversion INFO | application_version: 45.0a1 15:15:09 INFO - mozversion INFO | platform_buildid: 20151116135636 15:15:09 INFO - mozversion INFO | platform_changeset: 6f40e9b622236da96a2c10e57b95118acc85ecd4 15:15:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:15:09 INFO - mozversion INFO | platform_version: 45.0a1 15:15:09 INFO - 2015-11-16 15:15:09,256 DEBUG : using testdate: 1447715709 15:15:09 INFO - 2015-11-16 15:15:09,257 DEBUG : actual date: 1447715709 15:15:09 INFO - 2015-11-16 15:15:09,267 INFO : starting webserver on 'localhost:49266' 15:15:09 INFO - 2015-11-16 15:15:09,268 INFO : Starting test suite t-yosemite-r5-0026.e 15:15:09 INFO - 2015-11-16 15:15:09,268 INFO : Starting test dromaeo_css 15:15:09 INFO - 2015-11-16 15:15:09,268 DEBUG : operating with platform_type : mac_ 15:15:09 INFO - 2015-11-16 15:15:09,269 INFO : Initialising browser for dromaeo_css test... 15:15:09 INFO - 2015-11-16 15:15:09,291 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpCJFN1K/profile http://localhost:49266/getInfo.html 15:15:13 INFO - 2015-11-16 15:15:13,619 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:15:13 INFO - 2015-11-16 15:15:13,619 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:15:13 INFO - 2015-11-16 15:15:13,619 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:15:13 INFO - 2015-11-16 15:15:13,619 DEBUG : BROWSER_OUTPUT: __metrics 15:15:14 INFO - 2015-11-16 15:15:14,310 INFO : Browser initialized. 15:15:14 INFO - 2015-11-16 15:15:14,311 INFO : Running cycle 1/1 for dromaeo_css test... 15:15:14 INFO - 2015-11-16 15:15:14,311 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpCJFN1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:15:26 INFO - 2015-11-16 15:15:26,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 239886336 15:15:26 INFO - 2015-11-16 15:15:26,454 DEBUG : BROWSER_OUTPUT: 15:16:16 INFO - 2015-11-16 15:16:16,298 DEBUG : BROWSER_OUTPUT: 1447715776295 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] 15:18:27 INFO - 2015-11-16 15:18:27,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 15:18:28 INFO - 2015-11-16 15:18:28,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 268251136 15:18:28 INFO - 2015-11-16 15:18:28,464 DEBUG : BROWSER_OUTPUT: 15:21:30 INFO - 2015-11-16 15:21:30,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 15:21:31 INFO - 2015-11-16 15:21:31,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 273125376 15:21:31 INFO - 2015-11-16 15:21:31,020 DEBUG : BROWSER_OUTPUT: 15:24:32 INFO - 2015-11-16 15:24:32,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 15:24:33 INFO - 2015-11-16 15:24:33,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 276799488 15:24:33 INFO - 2015-11-16 15:24:33,331 DEBUG : BROWSER_OUTPUT: 15:27:35 INFO - 2015-11-16 15:27:35,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 15:27:35 INFO - 2015-11-16 15:27:35,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 281513984 15:27:35 INFO - 2015-11-16 15:27:35,657 DEBUG : BROWSER_OUTPUT: 15:30:38 INFO - 2015-11-16 15:30:38,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 15:30:38 INFO - 2015-11-16 15:30:38,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 286564352 15:30:38 INFO - 2015-11-16 15:30:38,852 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 15:33:41 INFO - 2015-11-16 15:33:41,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 291545088 15:33:41 INFO - 2015-11-16 15:33:41,410 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,410 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:33:41 INFO - 2015-11-16 15:33:41,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:33:41 INFO - 2015-11-16 15:33:41,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:33:41 INFO - 2015-11-16 15:33:41,410 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:33:41 INFO - 2015-11-16 15:33:41,411 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2778.513760091984;2813.5076361636707;2830.4056148208874;2893.609362736033;2930.208843612225;4838.10495058414;4854.5873600743935;4875.585575226106;4903.534164254399;4954.479779623141;4647;4746.3117847912035;4746.6440016998695;4789.640776941735;4824.228123500241;4432.423784907957;4568.497465278817;4606.493285738566;4607.216773148556;4685.484596694361;4458;4623.722576645395;4657.347971284023;4660.394148760656;4704.576588107069;4476.440444944382;4479.865604031885;4519.050999290153;4544.363789069533;4680.976595117019;4444.088961762831;4506.7070640408265;4517.977410112929;4552.499225085238;4576.977115114403;4527.162474942146;4573.977130114328;4588.2888152336445;4607.723536587782;4617.30740388941;4644.2801365788355;4685.5314468553215;4736.692115012514;4797.472278049412;4816.56650901417;5175.223716442526;5216.973915130438;5237.842864714026;5245.082110630662;5259.894802103937;5176.197689358156;5269.552088072518;5287.180487024518;5288.735563221823;5324.8136315228785;4763.76181190939;4767.928481072787;4805.663603547718;4857.465678775332;4918.704877707313;5090.898182036412;5124.282600435942;5163.690178589297;5165.74171291434;5207.947920520822;4923.77842997066;4978.178600530944;4982.202847544448;4989.800407983713;5005.799768009311;4968.627352948543;5069.290299358019;5099.515546023122;5181.689098654093;5256.579473642176;5070.239464080418;5087.109755792721;5087.465816089258;5090.312807770903;5107.284980102789;4921.655484116078;5020.598352131894;5106.157484015096;5109.795608175706;5124.641275110781;3864.9227015459533;3954.9011274718364;3978.8607398740905;3992.9001774955277;4013.6387725104883;3551.147724546142;3645.65366290202;3650.908727281786;3652.160003199279;3670.1742108026015;4736.739479328601;4812.302216178635;4881.8771682513225;4883.853484395474;4902.558769710743;5138.845834624967;5148.099082660519;5156.9742151289;5191.598268467568;5210.635255532076;4861.562459378673;4904.926426103611;4938.728369939688;4941.752912354368;4947.480514545993;4347.652187824967;4429.313456414261;4537.727736335831;4571.1543364477675;4666.440027196758;5340.626156169031;5363.356397232357;5373.11343628297;5415.431379705232;5429.077056900257;5220.138677118233;5233.162693969099;5290.947090529199;5296.761645725875;5309.36287645485;5059.392872855134;5236.136037553913;5241.292425522505;5376.946230537645;5381.704006279692;5092.694438333712;5096.108181068373;5144.948550514447;5145.845624631267;5179.352580927384;5150.124478838681;5209.218617207298;5214.243934629381;5220.138677118233;5229.660072095454;4967.7516124192925;5000.699958002531;5096.980603879165;5105.693658380509;5210.14032684618;5064.442911279682;5092.134337162617;5093.898122037613;5096.974515127401;5130.846074617767;4735.100330937111;4930.186519224288;4981.501849814989;4984.327115839315;5002.799888004584;4869.366982292279;5021.924671130009;5041.092603331289;5093.134167191661;5094.566961808139;4962.8759281018265;5017.046761115376;5041.6722913010535;5044.445111037856;5110.361204849394 15:33:41 INFO - 2015-11-16 15:33:41,415 DEBUG : BROWSER_OUTPUT: |1;ext.html;497.56960229401557;497.8755311172207;516.9353830771156;520.307990372804;528.859852139183;35584;36265.45601815968;36668.633313666855;36860.447093293624;37110.443343349834;37481.06297342561;37703.811480942626;37825.43261851074;38109.80945095271;38295.234095318076;8017.478863873829;8206.425550211488;8220.177982201792;8235.83528329436;8239.052508961457;8063.879041814348;8216.424850260484;8227.670893164266;8233.917660823376;8239.299659528948;8102.351811855067;8170.346372290202;8179.304759095484;8190.836183276331;8213.671453141867;8197.098319184885;8212;8279.213474719922;8279.254867061933;8425.620847061835;7914.80212994674;8050.919490805076;8065.435419520636;8075.596220189026;8091.474054186459;34622.30755384903;35127.82436087803;35199;35245.295094098234;35450;2544.6691930048974;2623.842569445839;2635.5387807133866;2662.8934842606272;3107.8756849725983;24530.264092077265;24760.25719228426;24934.625980610304;25115.246542603752;26080.217593472225;2097.0668052716546;2108.68369744538;2113.260358874397;2150.311900191939;2229.7547269800307;246804;247807;248135;248346;248700.75649621818;50561.24158137631;52753.736231319366;55600.44399556034;56040.71979640076;59634.10548841771;56271.155932661044;56405;57178;57525;57586.13620795608;14883.255837208097;14890.255487225595;14921.880858935623;15057.397704091933;15090.094594324375;11266.718332041764;11361.375124368074;11386.715332116763;11388.829167562493;11430.428478576037;17723;17949.910250448924;18134;18222.908885455487;18374.17316220773;7063.788086357417;7274.127104747358;7292.307230813064;7328.890066649004;7335.303146201102;754.1741792736944;818.6357071103421;819.868820988639;838.6100463284602;939.6945992552311;25256.242312730647;25819.225423237334;25970.610440843404;26038.08866689657;26101.73898261031;905.9003509613938;912.1061359867367;922.077922077922;950.1258841865363;973.2943615878431;13242.337883105805;13275.800862987064;13535.526256580972;13579.52471663487;13942.37259323333;268158;269203;272958;272990;274121;49278.26082608764;49424;49468.75265623649;49712.25431618529;49808.25287620688;1228.4656174564093;1254;1254.667513109027;1260.9117361784588;1410.0904916328911;26016.34959126037;26282.4743505125;26616.866915665298;26674;26698.19905402841;43112.137757244054;43270.56729432791;43282.78358608187;43504.564954350055;43623.11088003079;239478;240806;241951;242168;243098;24722.876385617958;25232.116875909254;26999.460010800067;27213.455730885667;28478;36864;37239.441408378356;37374.8131259342;37404;37826.810865945496;30995.845020774752;31302.686973130887;31698.68301316957;31956.52065218977;32056.5191522132;30996.22509437282;31036.22409439782;31290;31494.21264468315;31737.20656983594;31032.379352412372;31860.8406957973;32106.678933211304;32360.514592280662;32372;26542.469150617264;27452.45095098047;27492.45015099727;27859.16422507328;27947.86026069938;21020;21297.148114075884;21315.786842132;21468.248611298528;21601.135954561643 15:33:41 INFO - 2015-11-16 15:33:41,416 DEBUG : BROWSER_OUTPUT: |2;jquery.html;299.25784055542266;299.99700002999975;303.541652105321;304.5234208463754;310.31885012397794;10447.216458765604;11049.447527623606;15197.4680886169;15613.843861561367;15946.601334966632;10339.896601033988;10518.737031574214;10609.4164820935;10800.56797728092;10882.782344353109;3888.591697871725;4015.257177422186;4018.4374187613757;4019.196160767858;4054.736442131252;3910.902227444308;3964.6630036446936;4011.6389524942897;4050.6961977851633;4060.2285565742413;3990.8603198888045;4015.638592526672;4033.899152521181;4079.714419990587;4115.115250221202;4102.794860256975;4117.3618089196225;4124.154548317618;4140.399642051916;4184.811683474251;3417.094469965461;3515.806630635314;3526.7354948378975;3656.872009479682;3671.1005803578028;11460.14048946324;11521.827172592419;11708.004819590346;11753.059755219561;11789.292642441482;691.7475121580587;1625.1061915946182;1639.8848782827672;1778.5642517583276;1844.6126313474188;8002.479838810459;8259.174082591693;8421.115782842775;8586.570671466465;8650.524221167832;1372.1286982766017;1378.4486205517874;1399.825021872266;1405.5316716781372;1440.7622742247622;52354;52459.73770131125;53396.999999999614;53506;54281.72859135718;5726.226959360433;5749.453801888814;5764.193012978187;5822.912656310159;5840.678762668009;6612.669366531654;6614.669266536654;6626.83432914181;6627.03907933347;6673.799786006428;4812.494688057774;4813.109574728686;4916.852494425173;4919.99140176263;4943.7640589852535;5265.368155821326;5266.420693723688;5303.310569625924;5357.571394288448;5366.838994830161;2542.720300766914;2579.3035880312586;2579.6775403074616;2597.8701064946677;2612.542805009116;915.8855143107112;917.0691747875911;932.2495391210006;932.7574830543972;997.1125698128672;341.5269851255979;348.3120836348192;380.14088160756336;388.4833171881391;391.88831183112677;10026.398416095057;10217;10287.845682314772;10391.688249352532;10508.264421490576;400.97393669411395;405.7301894240356;406.989825254371;408.65876992710827;425.34284530399987;5520.1443776214755;5576.693281869455;5612.971935140298;5651.773929042793;5664.54683625309;495807;502108;505065;542293;543683;60805;62591.374086259464;62957.37042629515;63563;65002.67498662476;452.5225886689574;457.14742006158275;458.1935793004336;458.6216371493531;458.62621963100634;9468.201041802036;9588.424694518351;9684.32209745311;9690.70927872165;9723.85414218773;30526;30887.382252355277;31125.37749244957;31263.374732504766;31424.842875785474;41954.580454195064;42244;42521.149577007665;42670.35994460023;42750;5455.481729235717;5471.398146203835;5536.7231638418725;5539.529140022982;5611.943880561305;10335.483225838829;10488.790224195625;10594.2584019121;10693.358398495804;10696.090832279344;7838.764837054898;9148.542572871196;9184.173424391836;9267.629294828132;9279.582418791035;8402.285805706584;8559;8783.824323513621;8821.60302786389;8861.91138088611;8073.798155046171;9089.772755680897;9257.25941924631;9347.29895257872;9454.905450945678;5441.591880609049;5449.863753406196;5524.06090964529;5552.750126244248;5581.7209139543675;8877.37858349935;9047.954760226157;9108.453492790453;9210.677626283048;9217.723468295962 15:33:41 INFO - 2015-11-16 15:33:41,420 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1264.2288204195443;1368.302165895393;1451.2018389885561;1635.533872846239;1650;6254.343293954137;6294.150289710888;6901;6997.405220556252;7063.788086357411;6930.0990871186805;6933.687984040717;7029.789106326818;7117.679704413301;7123.893141602867;2023.7065625484297;2045.253482478892;2045.4886278430392;2069.6998935154393;2071.4717746974575;2074.8547601667888;2080.9063592138314;2110.472381904524;2133.2746866065536;2137.1130980643015;2039.1333683184662;2055.629986602411;2086.2280956046284;2103.758067822205;2112.5035616630157;2016.41523958052;2018.777934427212;2026.189524190321;2032.2175962254491;2034.735484387035;1991.8705284156483;2031.4718173275055;2111.873287602749;2113.144176608476;2128.8190503807195;7124.643767811641;7126.857462850766;7168.103987001625;7207.243239459886;7216.530925489878;4429.9114017719785;4517.254652982254;4538.432695913011;4550;4559.338895860082;2682.852443115628;2686.7984901132495;2718.184544636601;2733.016114198887;2758.7930905181993;770.8959290495767;821.7206149909059;821.7575815134489;841.0370126205521;843.0263046181609;9404.294677899117;9423.151916327564;9425.528723563863;9512.1439070484;9528.523573821281;4086.6322031017353;4101.815418306123;4157.646600039031;4167.6874234432535;4200.306949353384;8178.754637360888;8220.095789463154;8227.341812654973;8283.95858020706;8300.252977232078;4526.185286648435;4534.183846907522;4547.522510136454;4588.632909367309;4601.654875884322;3659.6157403472253;3745.1573395985683;3996.1208534122447;4098.897527561835;4101.876943691635;3295.143262751702;3299.686529779667;3351.2292172799903;3373.5108409280515;3378.44927080053;1094.7974624694457;1098.1599076706325;1098.280626189847;1102.6416414665266;1111.9499622517005;1186.976260474803;1192.630284611773;1199.7240634653904;1217.5190799634095;1217.719924417389;6539.542232043711;6587.80236592903;6658.1011563438315;6673.265940746514;6704.597724136567;383.7582323136462;392.5132835284227;393.9822707978148;394.5226276205766;394.54233089615906;5155.32980712505;5159.535641792257;5171.663841850268;5194.506521880416;5243;7825.726099586487;7834.4124190685925;7890.447668663139;7959.403044771665;8054.516728996279;8134.511929284262;8247.21651443124;8321.08468068512;8323.916760832435;8352.66589336432;6318.842028949313;6733.427658648971;6775.593464392152;6825.624590647562;6850.246472887979;6477.676116194266;6499.350064993463;6551.672416379067;6574.3754343337305;6657.367550082734;7321.926780732125;7377.668004939684;7382.335589796729;7435.107787065586;7479;7491.662875170739;7577.128630207597;7630.923690763021;7665.8466830661955;7721.382289416945;5599.580031497735;5924;6331.873362532816;6342.175517182921;6365.777197798055;6251.624902505864;6646.235682896336;6646.700898459678;6681.832954176184;6684.832879177865;6142.170806941006;6148.9692551536955;6222.719977601109;6247;6262.906056409066;6012.398760124128;6096.725647345968;6138.109974053648;6221.5333849960525;6270.028145637433;6241.157443745036;6253.5622506424115;6304.338044505261;6356.2054743157105;6377.93622063792;5644.548436125182;5657.434256574475;5659.377468478382;5718.742656580381;5734.426557344233;5516.14499752539;5713.628614140068;5774.740136693775;5801.6519008859605;5912.497437717842 15:33:41 INFO - 2015-11-16 15:33:41,421 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.0394646362975;287.8201124297314;293.09726043785156;293.92945693033676;294.76271601360895;5759.366469688331;5833;5912.083627037805;5928.288605367362;5944.34612192659;5733.340665823432;5869.2369991901;5876.4417380348905;5881.882362352761;5886.823395298137;4451.844185453509;4470.508244093147;4483.677315192026;4489.057297967431;4493.101379724052;4289.828406863738;4323.2218200723855;4401.80191891364;4449.866504004885;4509.6392288616835;4397.934030989538;4407.625351845097;4415.911681766363;4416.933745993812;4432.246518091933;4406.779661016953;4422.159789639958;4441.356003379492;4449.332600109977;4474.024773525602;3742.925141497155;3787.280416720842;3795.430685397185;3797.9240415191543;3818.8281527331337;5496.285482887239;5684.488396044335;5687.40282270364;5688.033034384164;5702.030654788696;4899.583535399495;4911.5088491150955;4934.6792458490445;4959.950400495985;4979.751012449399;6088.269407671108;6117.143599896018;6133.172021777048;6139.815805525842;6146.108814221912;4005.35914253718;4051.129007263423;4056.6957478189256;4058.1072164123843;4071.0229544909007;6266.905996410058;6434.260060093103;6439.742410303582;6472.935270647327;6477.4170324671;4101.651359634465;4104.589541045872;4112.198121366365;4134.793260337031;4139.689523285766;4198.097409057067;4202.327627579572;4210.052738133957;4216.831326746896;4229.0273237155625;4834.6374021948495;4928.137575924199;4933.851984440473;4962.354893863775;4964.329815474937;6138.232720909887;6139.539534534928;6144.662043587646;6159.599626024294;6171.105189747551;1456.8980171388114;1469.0744830756769;1472.7054589082227;1473.6021274256104;1477.933492992818;930.6835675870236;938.2119020023214;939.8872135343665;947.5688561704408;952.7951490429452;5783.363829978699;5790;5842.415758424124;5843.649381037151;5845.766169353264;6283.214598175228;6316.968415157895;6508.9349106508325;6527.053577231275;6534.640594767334;5894.056950887837;5903.3801450847905;5927.762889484458;5932.911006334908;5954.225950626391;3421.469672200813;3455.4298540740497;3484.4424892017155;3514.10390350459;3518.5601799775027;6501.154849869581;6624.701888415033;6642.7342906284175;6650.70071846768;6680.632565208863;6614.503912206507;6623.668816559153;6679.098321726602;6702.530822842452;6708.228553716288;6636.435902948304;6698.028785826125;6708.127943367429;6711.429528490133;6711.597304161766;6334.904976425265;6419.871602568016;6441.3880681335195;6484.319146489551;6512.47900167976;6303.36966303366;6312.705895291546;6326.9683651581445;6363.427291543783;6381.87236255263;6582.539222254396;6679.398854102959;6680.933190668031;6681.198256209286;6710.16122984627;4056.9797151014054;4096.774677392772;4122.216778812016;4165.104502531849;4178.310578754593;6416.486681065597;6436.581622194542;6439.291677915519;6441.967790161207;6443.2590252119735;6248.375162483715;6257.030160325156;6258.43674069336;6273.686315684289;6278.686065696788;6058.666773327509;6256.7810126645345;6258;6259.6870156492905;6272.341404152498;6082.787102451393;6088.117223002729;6113.510919126548;6125.724342404514;6128.417800308964;6218.626882387071;6242.719077641426;6255.624662520263;6256.812295631138;6257.998720204745;5895.351511333835;5988.6706231157705;6114.113453549122;6132.08018797184;6132.35610260934 15:33:41 INFO - 2015-11-16 15:33:41,422 DEBUG : BROWSER_OUTPUT: |5;yui.html;575.8963386590415;576.1214148423653;620.0870315077984;630.8612105336828;647.873664635396;12163.270203787768;12370.876291237086;12482;12513.68715782106;12550.372481375929;10447.960643210321;10491.475426228697;10590.735231619194;12016.218945768518;12182.51269949201;788.7870275025725;791.956442395668;806.0528878567688;813.8046868751517;814.767791179514;792.5363662257586;798.6406117247233;806.0971711682923;807.4670717326566;810.4691427115249;809.1625167951172;817.9386546009043;820.3519219816338;822.3791037766478;825.3603457320564;815.1888870573788;819.4100247821559;820.024171236227;820.2863508747398;826.4751882554621;604.3533419241413;605.9606125601822;612.0207667731594;612.3447910735515;612.7120253480857;11076;11215.271007384576;11353.772924541463;11416.257943233662;11490.425478726114;8609.526476043815;8888.155625215593;9421.670241541582;9558.90441095587;9566;7856.371490280764;7979.920200797976;8031.919680803176;8079.555624440653;8094.392920530984;2920.474314623367;2923.985380073086;2955.6157699499145;2967.8516074196204;3068.5243787213017;39555;42531.36202956958;43088.56911430877;43198.56801431977;47070.058598828175;7823.569703666353;7840.882386764203;8158.592070396457;8202.507849529047;8627.137286271449;17133;17143.14284285806;17167.828321716624;17196;17267.309307627806;6152.938470615326;6216.906746398808;6218.9378106218355;6314.242290925118;6356.586821856565;3422.2299982504237;3487.7907325560545;3510.3330367230146;3558.5018097466377;3599.9100022499124;2707.10665480391;2737.7809775218334;2764.7926405519665;2764.7926405519665;2771.4457108577963;395.30426449449175;395.5530250816559;399.2434336931499;420.6865884915757;430.5371725395213;392.66034879828743;405.7808783257008;418.51034289880914;445.77711144427786;480.9422869255712;6620.635865027373;6960.651967401711;7537.736179233701;7809.68761249555;7851.05787305527;523.5026724611635;533.6051322021676;540.8323419739893;569.7749388991325;575.473441800756;3252.5121231815415;3496.4405695088662;3497.8076205808925;3503.702185314226;3571.142925697814;54049.459505405226;54789;54958.17562736562;55056;55141.44858551363;46178.307325390146;47285.5271447288;47783.761081194374;47877.521224788004;48436.27345589819;35074.29851402958;35574.822125889725;36722.816385918435;37703.24593508115;38176.236475270336;6889;7039.964800175966;7195.316444937723;7444.441666874898;7576;32572.185695356857;32697;33343.66656333503;33428.83285583654;33436.498452523716;39979.40030899481;41707.16585668331;43249.35125973176;43295;43602;6806.285340039422;6864.24493305726;6930.5148639594745;7043.436525077879;7106.324899134574;9518.476483793458;9874.605015799574;9927.106560409598;10113.14038306752;10290.434026128634;9286.95356523213;9510.95244523773;9792.314537982273;10028.197744180303;10230.846537301797;9549.379290346105;9784.217262619115;9852.162566181954;9861.260405469475;10278.794424111626;8682.044975052866;8739.03870574249;8778;8907;9095.863562046707;7988.800279993046;8038.115807261313;8092.6762929482165;8229.382796290183;9001.504917229615;7338.412926965723;7592.81017974555;8018.278354948083;8054.476459030145;8292.792680182802 15:33:41 INFO - 2015-11-16 15:33:41,422 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:33:41 INFO - 2015-11-16 15:33:41,422 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: __startTimestamp1447716821408__endTimestamp 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:33:41 INFO - 2015-11-16 15:33:41,423 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:33:41 INFO - 2015-11-16 15:33:41,424 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,424 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4824.72 Median:4968.63 stddev:513.16 (10.3%) stddev-sans-first:488.99 15:33:41 INFO - 2015-11-16 15:33:41,425 DEBUG : BROWSER_OUTPUT: Values: 2778.5 2813.5 2830.4 2893.6 2930.2 4838.1 4854.6 4875.6 4903.5 4954.5 4647.0 4746.3 4746.6 4789.6 4824.2 4432.4 4568.5 4606.5 4607.2 4685.5 4458.0 4623.7 4657.3 4660.4 4704.6 4476.4 4479.9 4519.1 4544.4 4681.0 4444.1 4506.7 4518.0 4552.5 4577.0 4527.2 4574.0 4588.3 4607.7 4617.3 4644.3 4685.5 4736.7 4797.5 4816.6 5175.2 5217.0 5237.8 5245.1 5259.9 5176.2 5269.6 5287.2 5288.7 5324.8 4763.8 4767.9 4805.7 4857.5 4918.7 5090.9 5124.3 5163.7 5165.7 5207.9 4923.8 4978.2 4982.2 4989.8 5005.8 4968.6 5069.3 5099.5 5181.7 5256.6 5070.2 5087.1 5087.5 5090.3 5107.3 4921.7 5020.6 5106.2 5109.8 5124.6 3864.9 3954.9 3978.9 3992.9 4013.6 3551.1 3645.7 3650.9 3652.2 3670.2 4736.7 4812.3 4881.9 4883.9 4902.6 5138.8 5148.1 5157.0 5191.6 5210.6 4861.6 4904.9 4938.7 4941.8 4947.5 4347.7 4429.3 4537.7 4571.2 4666.4 5340.6 5363.4 5373.1 5415.4 5429.1 5220.1 5233.2 5290.9 5296.8 5309.4 5059.4 5236.1 5241.3 5376.9 5381.7 5092.7 5096.1 5144.9 5145.8 5179.4 5150.1 5209.2 5214.2 5220.1 5229.7 4967.8 5000.7 5097.0 5105.7 5210.1 5064.4 5092.1 5093.9 5097.0 5130.8 4735.1 4930.2 4981.5 4984.3 5002.8 4869.4 5021.9 5041.1 5093.1 5094.6 4962.9 5017.0 5041.7 5044.4 5110.4 15:33:41 INFO - 2015-11-16 15:33:41,425 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,425 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40962.40 Median:32006.52 stddev:66285.14 (207.1%) stddev-sans-first:66401.46 15:33:41 INFO - 2015-11-16 15:33:41,427 DEBUG : BROWSER_OUTPUT: Values: 497.6 497.9 516.9 520.3 528.9 35584.0 36265.5 36668.6 36860.4 37110.4 37481.1 37703.8 37825.4 38109.8 38295.2 8017.5 8206.4 8220.2 8235.8 8239.1 8063.9 8216.4 8227.7 8233.9 8239.3 8102.4 8170.3 8179.3 8190.8 8213.7 8197.1 8212.0 8279.2 8279.3 8425.6 7914.8 8050.9 8065.4 8075.6 8091.5 34622.3 35127.8 35199.0 35245.3 35450.0 2544.7 2623.8 2635.5 2662.9 3107.9 24530.3 24760.3 24934.6 25115.2 26080.2 2097.1 2108.7 2113.3 2150.3 2229.8 246804.0 247807.0 248135.0 248346.0 248700.8 50561.2 52753.7 55600.4 56040.7 59634.1 56271.2 56405.0 57178.0 57525.0 57586.1 14883.3 14890.3 14921.9 15057.4 15090.1 11266.7 11361.4 11386.7 11388.8 11430.4 17723.0 17949.9 18134.0 18222.9 18374.2 7063.8 7274.1 7292.3 7328.9 7335.3 754.2 818.6 819.9 838.6 939.7 25256.2 25819.2 25970.6 26038.1 26101.7 905.9 912.1 922.1 950.1 973.3 13242.3 13275.8 13535.5 13579.5 13942.4 268158.0 269203.0 272958.0 272990.0 274121.0 49278.3 49424.0 49468.8 49712.3 49808.3 1228.5 1254.0 1254.7 1260.9 1410.1 26016.3 26282.5 26616.9 26674.0 26698.2 43112.1 43270.6 43282.8 43504.6 43623.1 239478.0 240806.0 241951.0 242168.0 243098.0 24722.9 25232.1 26999.5 27213.5 28478.0 36864.0 37239.4 37374.8 37404.0 37826.8 30995.8 31302.7 31698.7 31956.5 32056.5 30996.2 31036.2 31290.0 31494.2 31737.2 31032.4 31860.8 32106.7 32360.5 32372.0 26542.5 27452.5 27492.5 27859.2 27947.9 21020.0 21297.1 21315.8 21468.2 21601.1 15:33:41 INFO - 2015-11-16 15:33:41,427 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,427 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24582.29 Median:457.67 stddev:84859.99 (18541.7%) stddev-sans-first:85078.46 15:33:41 INFO - 2015-11-16 15:33:41,427 DEBUG : BROWSER_OUTPUT: Values: 299.3 300.0 303.5 304.5 310.3 10447.2 11049.4 15197.5 15613.8 15946.6 10339.9 10518.7 10609.4 10800.6 10882.8 3888.6 4015.3 4018.4 4019.2 4054.7 3910.9 3964.7 4011.6 4050.7 4060.2 3990.9 4015.6 4033.9 4079.7 4115.1 4102.8 4117.4 4124.2 4140.4 4184.8 3417.1 3515.8 3526.7 3656.9 3671.1 11460.1 11521.8 11708.0 11753.1 11789.3 691.7 1625.1 1639.9 1778.6 1844.6 8002.5 8259.2 8421.1 8586.6 8650.5 1372.1 1378.4 1399.8 1405.5 1440.8 52354.0 52459.7 53397.0 53506.0 54281.7 5726.2 5749.5 5764.2 5822.9 5840.7 6612.7 6614.7 6626.8 6627.0 6673.8 4812.5 4813.1 4916.9 4920.0 4943.8 5265.4 5266.4 5303.3 5357.6 5366.8 2542.7 2579.3 2579.7 2597.9 2612.5 915.9 917.1 932.2 932.8 997.1 341.5 348.3 380.1 388.5 391.9 10026.4 10217.0 10287.8 10391.7 10508.3 401.0 405.7 407.0 408.7 425.3 5520.1 5576.7 5613.0 5651.8 5664.5 495807.0 502108.0 505065.0 542293.0 543683.0 60805.0 62591.4 62957.4 63563.0 65002.7 452.5 457.1 458.2 458.6 458.6 9468.2 9588.4 9684.3 9690.7 9723.9 30526.0 30887.4 31125.4 31263.4 31424.8 41954.6 42244.0 42521.1 42670.4 42750.0 5455.5 5471.4 5536.7 5539.5 5611.9 10335.5 10488.8 10594.3 10693.4 10696.1 7838.8 9148.5 9184.2 9267.6 9279.6 8402.3 8559.0 8783.8 8821.6 8861.9 8073.8 9089.8 9257.3 9347.3 9454.9 5441.6 5449.9 5524.1 5552.8 5581.7 8877.4 9048.0 9108.5 9210.7 9217.7 15:33:41 INFO - 2015-11-16 15:33:41,427 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,428 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4893.91 Median:5918.25 stddev:2508.31 (42.4%) stddev-sans-first:2500.51 15:33:41 INFO - 2015-11-16 15:33:41,429 DEBUG : BROWSER_OUTPUT: Values: 1264.2 1368.3 1451.2 1635.5 1650.0 6254.3 6294.2 6901.0 6997.4 7063.8 6930.1 6933.7 7029.8 7117.7 7123.9 2023.7 2045.3 2045.5 2069.7 2071.5 2074.9 2080.9 2110.5 2133.3 2137.1 2039.1 2055.6 2086.2 2103.8 2112.5 2016.4 2018.8 2026.2 2032.2 2034.7 1991.9 2031.5 2111.9 2113.1 2128.8 7124.6 7126.9 7168.1 7207.2 7216.5 4429.9 4517.3 4538.4 4550.0 4559.3 2682.9 2686.8 2718.2 2733.0 2758.8 770.9 821.7 821.8 841.0 843.0 9404.3 9423.2 9425.5 9512.1 9528.5 4086.6 4101.8 4157.6 4167.7 4200.3 8178.8 8220.1 8227.3 8284.0 8300.3 4526.2 4534.2 4547.5 4588.6 4601.7 3659.6 3745.2 3996.1 4098.9 4101.9 3295.1 3299.7 3351.2 3373.5 3378.4 1094.8 1098.2 1098.3 1102.6 1111.9 1187.0 1192.6 1199.7 1217.5 1217.7 6539.5 6587.8 6658.1 6673.3 6704.6 383.8 392.5 394.0 394.5 394.5 5155.3 5159.5 5171.7 5194.5 5243.0 7825.7 7834.4 7890.4 7959.4 8054.5 8134.5 8247.2 8321.1 8323.9 8352.7 6318.8 6733.4 6775.6 6825.6 6850.2 6477.7 6499.4 6551.7 6574.4 6657.4 7321.9 7377.7 7382.3 7435.1 7479.0 7491.7 7577.1 7630.9 7665.8 7721.4 5599.6 5924.0 6331.9 6342.2 6365.8 6251.6 6646.2 6646.7 6681.8 6684.8 6142.2 6149.0 6222.7 6247.0 6262.9 6012.4 6096.7 6138.1 6221.5 6270.0 6241.2 6253.6 6304.3 6356.2 6377.9 5644.5 5657.4 5659.4 5718.7 5734.4 5516.1 5713.6 5774.7 5801.7 5912.5 15:33:41 INFO - 2015-11-16 15:33:41,429 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,429 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5140.41 Median:5919.92 stddev:1608.97 (27.2%) stddev-sans-first:1571.58 15:33:41 INFO - 2015-11-16 15:33:41,430 DEBUG : BROWSER_OUTPUT: Values: 280.0 287.8 293.1 293.9 294.8 5759.4 5833.0 5912.1 5928.3 5944.3 5733.3 5869.2 5876.4 5881.9 5886.8 4451.8 4470.5 4483.7 4489.1 4493.1 4289.8 4323.2 4401.8 4449.9 4509.6 4397.9 4407.6 4415.9 4416.9 4432.2 4406.8 4422.2 4441.4 4449.3 4474.0 3742.9 3787.3 3795.4 3797.9 3818.8 5496.3 5684.5 5687.4 5688.0 5702.0 4899.6 4911.5 4934.7 4960.0 4979.8 6088.3 6117.1 6133.2 6139.8 6146.1 4005.4 4051.1 4056.7 4058.1 4071.0 6266.9 6434.3 6439.7 6472.9 6477.4 4101.7 4104.6 4112.2 4134.8 4139.7 4198.1 4202.3 4210.1 4216.8 4229.0 4834.6 4928.1 4933.9 4962.4 4964.3 6138.2 6139.5 6144.7 6159.6 6171.1 1456.9 1469.1 1472.7 1473.6 1477.9 930.7 938.2 939.9 947.6 952.8 5783.4 5790.0 5842.4 5843.6 5845.8 6283.2 6317.0 6508.9 6527.1 6534.6 5894.1 5903.4 5927.8 5932.9 5954.2 3421.5 3455.4 3484.4 3514.1 3518.6 6501.2 6624.7 6642.7 6650.7 6680.6 6614.5 6623.7 6679.1 6702.5 6708.2 6636.4 6698.0 6708.1 6711.4 6711.6 6334.9 6419.9 6441.4 6484.3 6512.5 6303.4 6312.7 6327.0 6363.4 6381.9 6582.5 6679.4 6680.9 6681.2 6710.2 4057.0 4096.8 4122.2 4165.1 4178.3 6416.5 6436.6 6439.3 6442.0 6443.3 6248.4 6257.0 6258.4 6273.7 6278.7 6058.7 6256.8 6258.0 6259.7 6272.3 6082.8 6088.1 6113.5 6125.7 6128.4 6218.6 6242.7 6255.6 6256.8 6258.0 5895.4 5988.7 6114.1 6132.1 6132.4 15:33:41 INFO - 2015-11-16 15:33:41,430 DEBUG : BROWSER_OUTPUT: 15:33:41 INFO - 2015-11-16 15:33:41,431 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12105.49 Median:576.01 stddev:14705.31 (2553.0%) stddev-sans-first:14721.07 15:33:41 INFO - 2015-11-16 15:33:41,432 DEBUG : BROWSER_OUTPUT: Values: 575.9 576.1 620.1 630.9 647.9 12163.3 12370.9 12482.0 12513.7 12550.4 10448.0 10491.5 10590.7 12016.2 12182.5 788.8 792.0 806.1 813.8 814.8 792.5 798.6 806.1 807.5 810.5 809.2 817.9 820.4 822.4 825.4 815.2 819.4 820.0 820.3 826.5 604.4 606.0 612.0 612.3 612.7 11076.0 11215.3 11353.8 11416.3 11490.4 8609.5 8888.2 9421.7 9558.9 9566.0 7856.4 7979.9 8031.9 8079.6 8094.4 2920.5 2924.0 2955.6 2967.9 3068.5 39555.0 42531.4 43088.6 43198.6 47070.1 7823.6 7840.9 8158.6 8202.5 8627.1 17133.0 17143.1 17167.8 17196.0 17267.3 6152.9 6216.9 6218.9 6314.2 6356.6 3422.2 3487.8 3510.3 3558.5 3599.9 2707.1 2737.8 2764.8 2764.8 2771.4 395.3 395.6 399.2 420.7 430.5 392.7 405.8 418.5 445.8 480.9 6620.6 6960.7 7537.7 7809.7 7851.1 523.5 533.6 540.8 569.8 575.5 3252.5 3496.4 3497.8 3503.7 3571.1 54049.5 54789.0 54958.2 55056.0 55141.4 46178.3 47285.5 47783.8 47877.5 48436.3 35074.3 35574.8 36722.8 37703.2 38176.2 6889.0 7040.0 7195.3 7444.4 7576.0 32572.2 32697.0 33343.7 33428.8 33436.5 39979.4 41707.2 43249.4 43295.0 43602.0 6806.3 6864.2 6930.5 7043.4 7106.3 9518.5 9874.6 9927.1 10113.1 10290.4 9287.0 9511.0 9792.3 10028.2 10230.8 9549.4 9784.2 9852.2 9861.3 10278.8 8682.0 8739.0 8778.0 8907.0 9095.9 7988.8 8038.1 8092.7 8229.4 9001.5 7338.4 7592.8 8018.3 8054.5 8292.8 15:33:41 INFO - 2015-11-16 15:33:41,432 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:33:41 INFO - 2015-11-16 15:33:41,432 DEBUG : BROWSER_OUTPUT: 15:33:42 INFO - 2015-11-16 15:33:42,111 INFO : Browser exited with error code: 0 15:33:42 INFO - 2015-11-16 15:33:42,142 INFO : Completed test dromaeo_css (00:18:32) 15:33:42 INFO - 2015-11-16 15:33:42,142 INFO : Starting test kraken 15:33:42 INFO - 2015-11-16 15:33:42,142 DEBUG : operating with platform_type : mac_ 15:33:42 INFO - 2015-11-16 15:33:42,142 INFO : Initialising browser for kraken test... 15:33:42 INFO - 2015-11-16 15:33:42,157 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmp2KEIMw/profile http://localhost:49266/getInfo.html 15:33:45 INFO - 2015-11-16 15:33:45,186 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:33:45 INFO - 2015-11-16 15:33:45,186 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:33:45 INFO - 2015-11-16 15:33:45,186 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:33:45 INFO - 2015-11-16 15:33:45,186 DEBUG : BROWSER_OUTPUT: __metrics 15:33:45 INFO - 2015-11-16 15:33:45,888 INFO : Browser initialized. 15:33:45 INFO - 2015-11-16 15:33:45,888 INFO : Running cycle 1/1 for kraken test... 15:33:45 INFO - 2015-11-16 15:33:45,888 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmp2KEIMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:33:57 INFO - 2015-11-16 15:33:57,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 241369088 15:33:57 INFO - 2015-11-16 15:33:57,967 DEBUG : BROWSER_OUTPUT: 15:34:00 INFO - 2015-11-16 15:34:00,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:01 INFO - 2015-11-16 15:34:01,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 258785280 15:34:01 INFO - 2015-11-16 15:34:01,230 DEBUG : BROWSER_OUTPUT: 15:34:04 INFO - 2015-11-16 15:34:04,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 15:34:04 INFO - 2015-11-16 15:34:04,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 267882496 15:34:04 INFO - 2015-11-16 15:34:04,744 DEBUG : BROWSER_OUTPUT: 15:34:07 INFO - 2015-11-16 15:34:07,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 15:34:08 INFO - 2015-11-16 15:34:08,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 268230656 15:34:08 INFO - 2015-11-16 15:34:08,465 DEBUG : BROWSER_OUTPUT: 15:34:10 INFO - 2015-11-16 15:34:10,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 15:34:11 INFO - 2015-11-16 15:34:11,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 267370496 15:34:11 INFO - 2015-11-16 15:34:11,219 DEBUG : BROWSER_OUTPUT: 15:34:13 INFO - 2015-11-16 15:34:13,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:14 INFO - 2015-11-16 15:34:14,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 268914688 15:34:14 INFO - 2015-11-16 15:34:14,093 DEBUG : BROWSER_OUTPUT: 15:34:17 INFO - 2015-11-16 15:34:17,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:18 INFO - 2015-11-16 15:34:18,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 268742656 15:34:18 INFO - 2015-11-16 15:34:18,042 DEBUG : BROWSER_OUTPUT: 15:34:21 INFO - 2015-11-16 15:34:21,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:22 INFO - 2015-11-16 15:34:22,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 268955648 15:34:22 INFO - 2015-11-16 15:34:22,082 DEBUG : BROWSER_OUTPUT: 15:34:25 INFO - 2015-11-16 15:34:25,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 15:34:25 INFO - 2015-11-16 15:34:25,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 269225984 15:34:25 INFO - 2015-11-16 15:34:25,831 DEBUG : BROWSER_OUTPUT: 15:34:27 INFO - 2015-11-16 15:34:27,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:28 INFO - 2015-11-16 15:34:28,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 268898304 15:34:28 INFO - 2015-11-16 15:34:28,126 DEBUG : BROWSER_OUTPUT: 15:34:30 INFO - 2015-11-16 15:34:30,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:30 INFO - 2015-11-16 15:34:30,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 268140544 15:34:30 INFO - 2015-11-16 15:34:30,746 DEBUG : BROWSER_OUTPUT: 15:34:33 INFO - 2015-11-16 15:34:33,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:33 INFO - 2015-11-16 15:34:33,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 267898880 15:34:33 INFO - 2015-11-16 15:34:33,609 DEBUG : BROWSER_OUTPUT: 15:34:36 INFO - 2015-11-16 15:34:36,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:37 INFO - 2015-11-16 15:34:37,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 267923456 15:34:37 INFO - 2015-11-16 15:34:37,038 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-16 15:34:39,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:40 INFO - 2015-11-16 15:34:40,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 267681792 15:34:40 INFO - 2015-11-16 15:34:40,472 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 15:34:42 INFO - 2015-11-16 15:34:42,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 269279232 15:34:42 INFO - 2015-11-16 15:34:42,570 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,570 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:34:42 INFO - 2015-11-16 15:34:42,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:34:42 INFO - 2015-11-16 15:34:42,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:34:42 INFO - 2015-11-16 15:34:42,570 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;105;113;117;119;134;127;128;125;121 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;173;155;177;187;154;172;163;150;190;155 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;185;192;197;196;186;186;185;195;195 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;82;86;91;130;78;78;98;80;128 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;99;148;98;101;100;143;105;106;148 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;136;142;134;136;136;141;136;142;142 15:34:42 INFO - 2015-11-16 15:34:42,571 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;142;151;149;149;143;150;150;144 15:34:42 INFO - 2015-11-16 15:34:42,572 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;113;112;121;124;118;112;108;122;122 15:34:42 INFO - 2015-11-16 15:34:42,572 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;70;72;74;76;75;74;82;73;76 15:34:42 INFO - 2015-11-16 15:34:42,572 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;75;81;81;83;83;84;82;81;81;82 15:34:42 INFO - 2015-11-16 15:34:42,572 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;98;103;101;103;104;104;102;102;99 15:34:42 INFO - 2015-11-16 15:34:42,572 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;151;147;154;148;160;158;150;147;151 15:34:42 INFO - 2015-11-16 15:34:42,573 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;179;180;164;173;168;190;179;173;163 15:34:42 INFO - 2015-11-16 15:34:42,573 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;80;81;82;84;84;83;87;79;81 15:34:42 INFO - 2015-11-16 15:34:42,573 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:34:42 INFO - 2015-11-16 15:34:42,575 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:34:42 INFO - 2015-11-16 15:34:42,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,722 15:34:42 INFO - 2015-11-16 15:34:42,575 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:34:42 INFO - 2015-11-16 15:34:42,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1447716882569__endTimestamp 15:34:42 INFO - 2015-11-16 15:34:42,575 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:119.80 Median:123.00 stddev:9.07 (7.4%) stddev-sans-first:8.73 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: Values: 109.0 105.0 113.0 117.0 119.0 134.0 127.0 128.0 125.0 121.0 15:34:42 INFO - 2015-11-16 15:34:42,576 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:167.60 Median:172.50 stddev:14.33 (8.3%) stddev-sans-first:15.07 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: Values: 173.0 155.0 177.0 187.0 154.0 172.0 163.0 150.0 190.0 155.0 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:190.40 Median:193.50 stddev:5.04 (2.6%) stddev-sans-first:5.19 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: Values: 187.0 185.0 192.0 197.0 196.0 186.0 186.0 185.0 195.0 195.0 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.50 Median:81.00 stddev:20.47 (25.3%) stddev-sans-first:20.59 15:34:42 INFO - 2015-11-16 15:34:42,577 DEBUG : BROWSER_OUTPUT: Values: 74.0 82.0 86.0 91.0 130.0 78.0 78.0 98.0 80.0 128.0 15:34:42 INFO - 2015-11-16 15:34:42,578 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,578 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.50 Median:148.00 stddev:22.19 (15.0%) stddev-sans-first:22.61 15:34:42 INFO - 2015-11-16 15:34:42,578 DEBUG : BROWSER_OUTPUT: Values: 97.0 99.0 148.0 98.0 101.0 100.0 143.0 105.0 106.0 148.0 15:34:42 INFO - 2015-11-16 15:34:42,578 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,578 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:138.10 Median:138.50 stddev:3.21 (2.3%) stddev-sans-first:3.32 15:34:42 INFO - 2015-11-16 15:34:42,579 DEBUG : BROWSER_OUTPUT: Values: 136.0 136.0 142.0 134.0 136.0 136.0 141.0 136.0 142.0 142.0 15:34:42 INFO - 2015-11-16 15:34:42,579 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,579 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:149.00 stddev:3.27 (2.2%) stddev-sans-first:3.43 15:34:42 INFO - 2015-11-16 15:34:42,579 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 142.0 151.0 149.0 149.0 143.0 150.0 150.0 144.0 15:34:42 INFO - 2015-11-16 15:34:42,579 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,580 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.40 Median:121.50 stddev:5.64 (4.6%) stddev-sans-first:5.73 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: Values: 122.0 113.0 112.0 121.0 124.0 118.0 112.0 108.0 122.0 122.0 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.80 Median:74.50 stddev:4.18 (5.6%) stddev-sans-first:3.35 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: Values: 66.0 70.0 72.0 74.0 76.0 75.0 74.0 82.0 73.0 76.0 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:82.00 stddev:2.45 (3.0%) stddev-sans-first:1.12 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: Values: 75.0 81.0 81.0 83.0 83.0 84.0 82.0 81.0 81.0 82.0 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:101.10 Median:104.00 stddev:2.92 (2.8%) stddev-sans-first:2.11 15:34:42 INFO - 2015-11-16 15:34:42,581 DEBUG : BROWSER_OUTPUT: Values: 95.0 98.0 103.0 101.0 103.0 104.0 104.0 102.0 102.0 99.0 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:152.50 stddev:4.61 (3.0%) stddev-sans-first:4.68 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: Values: 156.0 151.0 147.0 154.0 148.0 160.0 158.0 150.0 147.0 151.0 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:176.00 stddev:9.05 (5.1%) stddev-sans-first:8.66 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: Values: 162.0 179.0 180.0 164.0 173.0 168.0 190.0 179.0 173.0 163.0 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: 15:34:42 INFO - 2015-11-16 15:34:42,582 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.80 Median:82.50 stddev:2.86 (3.5%) stddev-sans-first:2.45 15:34:42 INFO - 2015-11-16 15:34:42,583 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 81.0 82.0 84.0 84.0 83.0 87.0 79.0 81.0 15:34:42 INFO - 2015-11-16 15:34:42,583 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:34:42 INFO - 2015-11-16 15:34:42,583 DEBUG : BROWSER_OUTPUT: 15:34:43 INFO - 2015-11-16 15:34:43,278 INFO : Browser exited with error code: 0 15:34:43 INFO - 2015-11-16 15:34:43,329 INFO : Completed test kraken (00:01:01) 15:34:43 INFO - 2015-11-16 15:34:43,329 INFO : Starting test v8_7 15:34:43 INFO - 2015-11-16 15:34:43,329 DEBUG : operating with platform_type : mac_ 15:34:43 INFO - 2015-11-16 15:34:43,329 INFO : Initialising browser for v8_7 test... 15:34:43 INFO - 2015-11-16 15:34:43,343 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpP6KH_s/profile http://localhost:49266/getInfo.html 15:34:46 INFO - 2015-11-16 15:34:46,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:34:46 INFO - 2015-11-16 15:34:46,387 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:34:46 INFO - 2015-11-16 15:34:46,387 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:34:46 INFO - 2015-11-16 15:34:46,387 DEBUG : BROWSER_OUTPUT: __metrics 15:34:47 INFO - 2015-11-16 15:34:47,078 INFO : Browser initialized. 15:34:47 INFO - 2015-11-16 15:34:47,078 INFO : Running cycle 1/1 for v8_7 test... 15:34:47 INFO - 2015-11-16 15:34:47,079 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpP6KH_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:34:59 INFO - 2015-11-16 15:34:59,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 240209920 15:34:59 INFO - 2015-11-16 15:34:59,154 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 15:35:21 INFO - 2015-11-16 15:35:21,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 260669440 15:35:21 INFO - 2015-11-16 15:35:21,976 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,976 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:35:21 INFO - 2015-11-16 15:35:21,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: |0;Richards;177.1793054571226 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;219.4426157559798 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: |2;Encrypt;352.98270384751146 15:35:21 INFO - 2015-11-16 15:35:21,977 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6622.516556291391 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1267.427122940431 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |5;Earley;891.3624220837044 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |6;Boyer;15074.626865671642 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |7;RegExp;34152.542372881355 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |8;Splay;678.8866259334691 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6416.666666666667 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: __startTimestamp1447716921974__endTimestamp 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:35:21 INFO - 2015-11-16 15:35:21,978 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:177.18 Median:177.18 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: Values: 177.2 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:219.44 Median:219.44 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: Values: 219.4 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:352.98 Median:352.98 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: Values: 353.0 15:35:21 INFO - 2015-11-16 15:35:21,979 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6622.52 Median:6622.52 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: Values: 6622.5 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1267.43 Median:1267.43 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: Values: 1267.4 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,980 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:891.36 Median:891.36 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: Values: 891.4 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15074.63 Median:15074.63 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: Values: 15074.6 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34152.54 Median:34152.54 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,981 DEBUG : BROWSER_OUTPUT: Values: 34152.5 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:678.89 Median:678.89 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: Values: 678.9 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6416.67 Median:6416.67 stddev:0.00 (0.0%) 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: Values: 6416.7 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:35:21 INFO - 2015-11-16 15:35:21,982 DEBUG : BROWSER_OUTPUT: 15:35:22 INFO - 2015-11-16 15:35:22,667 INFO : Browser exited with error code: 0 15:35:22 INFO - 2015-11-16 15:35:22,688 INFO : Completed test v8_7 (00:00:39) 15:35:22 INFO - 2015-11-16 15:35:22,969 INFO : Completed test suite (00:20:13) 15:35:22 INFO - 2015-11-16 15:35:22,969 DEBUG : Working with test: dromaeo_css 15:35:22 INFO - 2015-11-16 15:35:22,969 DEBUG : Generating results file: dromaeo_css 15:35:22 INFO - 2015-11-16 15:35:22,970 DEBUG : Working with test: kraken 15:35:22 INFO - 2015-11-16 15:35:22,970 DEBUG : Generating results file: kraken 15:35:22 INFO - 2015-11-16 15:35:22,970 INFO : javascript benchmark 15:35:22 INFO - 2015-11-16 15:35:22,970 DEBUG : Working with test: v8_7 15:35:22 INFO - 2015-11-16 15:35:22,970 DEBUG : Generating results file: v8_7 15:35:22 INFO - 2015-11-16 15:35:22,970 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:23 INFO - 2015-11-16 15:35:23,022 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 15:35:23 INFO - 2015-11-16 15:35:23,023 DEBUG : process_Request line: dromaeo_css 5960.16 graph.html#tests=[[72,63,57]] 15:35:23 INFO - 2015-11-16 15:35:23,023 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:23 INFO - 2015-11-16 15:35:23,122 DEBUG : process_Request line: kraken 1751.20 graph.html#tests=[[232,63,57]] 15:35:23 INFO - 2015-11-16 15:35:23,122 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:23 INFO - 2015-11-16 15:35:23,150 DEBUG : process_Request line: v8_7 17529.50 graph.html#tests=[[230,63,57]] 15:35:23 INFO - 2015-11-16 15:35:23,151 INFO : javascript benchmark 15:35:23 INFO - 2015-11-16 15:35:23,153 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [299.25784055542266, 299.99700002999975, 303.541652105321, 304.5234208463754, 310.31885012397794, 10447.216458765604, 11049.447527623606, 15197.4680886169, 15613.843861561367, 15946.601334966632, 10339.896601033988, 10518.737031574214, 10609.4164820935, 10800.56797728092, 10882.782344353109, 3888.591697871725, 4015.257177422186, 4018.4374187613757, 4019.196160767858, 4054.736442131252, 3910.902227444308, 3964.6630036446936, 4011.6389524942897, 4050.6961977851633, 4060.2285565742413, 3990.8603198888045, 4015.638592526672, 4033.899152521181, 4079.714419990587, 4115.115250221202, 4102.794860256975, 4117.3618089196225, 4124.154548317618, 4140.399642051916, 4184.811683474251, 3417.094469965461, 3515.806630635314, 3526.7354948378975, 3656.872009479682, 3671.1005803578028, 11460.14048946324, 11521.827172592419, 11708.004819590346, 11753.059755219561, 11789.292642441482, 691.7475121580587, 1625.1061915946182, 1639.8848782827672, 1778.5642517583276, 1844.6126313474188, 8002.479838810459, 8259.174082591693, 8421.115782842775, 8586.570671466465, 8650.524221167832, 1372.1286982766017, 1378.4486205517874, 1399.825021872266, 1405.5316716781372, 1440.7622742247622, 52354.0, 52459.73770131125, 53396.999999999614, 53506.0, 54281.72859135718, 5726.226959360433, 5749.453801888814, 5764.193012978187, 5822.912656310159, 5840.678762668009, 6612.669366531654, 6614.669266536654, 6626.83432914181, 6627.03907933347, 6673.799786006428, 4812.494688057774, 4813.109574728686, 4916.852494425173, 4919.99140176263, 4943.7640589852535, 5265.368155821326, 5266.420693723688, 5303.310569625924, 5357.571394288448, 5366.838994830161, 2542.720300766914, 2579.3035880312586, 2579.6775403074616, 2597.8701064946677, 2612.542805009116, 915.8855143107112, 917.0691747875911, 932.2495391210006, 932.7574830543972, 997.1125698128672, 341.5269851255979, 348.3120836348192, 380.14088160756336, 388.4833171881391, 391.88831183112677, 10026.398416095057, 10217.0, 10287.845682314772, 10391.688249352532, 10508.264421490576, 400.97393669411395, 405.7301894240356, 406.989825254371, 408.65876992710827, 425.34284530399987, 5520.1443776214755, 5576.693281869455, 5612.971935140298, 5651.773929042793, 5664.54683625309, 495807.0, 502108.0, 505065.0, 542293.0, 543683.0, 60805.0, 62591.374086259464, 62957.37042629515, 63563.0, 65002.67498662476, 452.5225886689574, 457.14742006158275, 458.1935793004336, 458.6216371493531, 458.62621963100634, 9468.201041802036, 9588.424694518351, 9684.32209745311, 9690.70927872165, 9723.85414218773, 30526.0, 30887.382252355277, 31125.37749244957, 31263.374732504766, 31424.842875785474, 41954.580454195064, 42244.0, 42521.149577007665, 42670.35994460023, 42750.0, 5455.481729235717, 5471.398146203835, 5536.7231638418725, 5539.529140022982, 5611.943880561305, 10335.483225838829, 10488.790224195625, 10594.2584019121, 10693.358398495804, 10696.090832279344, 7838.764837054898, 9148.542572871196, 9184.173424391836, 9267.629294828132, 9279.582418791035, 8402.285805706584, 8559.0, 8783.824323513621, 8821.60302786389, 8861.91138088611, 8073.798155046171, 9089.772755680897, 9257.25941924631, 9347.29895257872, 9454.905450945678, 5441.591880609049, 5449.863753406196, 5524.06090964529, 5552.750126244248, 5581.7209139543675, 8877.37858349935, 9047.954760226157, 9108.453492790453, 9210.677626283048, 9217.723468295962], "dojo.html": [2778.513760091984, 2813.5076361636707, 2830.4056148208874, 2893.609362736033, 2930.208843612225, 4838.10495058414, 4854.5873600743935, 4875.585575226106, 4903.534164254399, 4954.479779623141, 4647.0, 4746.3117847912035, 4746.6440016998695, 4789.640776941735, 4824.228123500241, 4432.423784907957, 4568.497465278817, 4606.493285738566, 4607.216773148556, 4685.484596694361, 4458.0, 4623.722576645395, 4657.347971284023, 4660.394148760656, 4704.576588107069, 4476.440444944382, 4479.865604031885, 4519.050999290153, 4544.363789069533, 4680.976595117019, 4444.088961762831, 4506.7070640408265, 4517.977410112929, 4552.499225085238, 4576.977115114403, 4527.162474942146, 4573.977130114328, 4588.2888152336445, 4607.723536587782, 4617.30740388941, 4644.2801365788355, 4685.5314468553215, 4736.692115012514, 4797.472278049412, 4816.56650901417, 5175.223716442526, 5216.973915130438, 5237.842864714026, 5245.082110630662, 5259.894802103937, 5176.197689358156, 5269.552088072518, 5287.180487024518, 5288.735563221823, 5324.8136315228785, 4763.76181190939, 4767.928481072787, 4805.663603547718, 4857.465678775332, 4918.704877707313, 5090.898182036412, 5124.282600435942, 5163.690178589297, 5165.74171291434, 5207.947920520822, 4923.77842997066, 4978.178600530944, 4982.202847544448, 4989.800407983713, 5005.799768009311, 4968.627352948543, 5069.290299358019, 5099.515546023122, 5181.689098654093, 5256.579473642176, 5070.239464080418, 5087.109755792721, 5087.465816089258, 5090.312807770903, 5107.284980102789, 4921.655484116078, 5020.598352131894, 5106.157484015096, 5109.795608175706, 5124.641275110781, 3864.9227015459533, 3954.9011274718364, 3978.8607398740905, 3992.9001774955277, 4013.6387725104883, 3551.147724546142, 3645.65366290202, 3650.908727281786, 3652.160003199279, 3670.1742108026015, 4736.739479328601, 4812.302216178635, 4881.8771682513225, 4883.853484395474, 4902.558769710743, 5138.845834624967, 5148.099082660519, 5156.9742151289, 5191.598268467568, 5210.635255532076, 4861.562459378673, 4904.926426103611, 4938.728369939688, 4941.752912354368, 4947.480514545993, 4347.652187824967, 4429.313456414261, 4537.727736335831, 4571.1543364477675, 4666.440027196758, 5340.626156169031, 5363.356397232357, 5373.11343628297, 5415.431379705232, 5429.077056900257, 5220.138677118233, 5233.162693969099, 5290.947090529199, 5296.761645725875, 5309.36287645485, 5059.392872855134, 5236.136037553913, 5241.292425522505, 5376.946230537645, 5381.704006279692, 5092.694438333712, 5096.108181068373, 5144.948550514447, 5145.845624631267, 5179.352580927384, 5150.124478838681, 5209.218617207298, 5214.243934629381, 5220.138677118233, 5229.660072095454, 4967.7516124192925, 5000.699958002531, 5096.980603879165, 5105.693658380509, 5210.14032684618, 5064.442911279682, 5092.134337162617, 5093.898122037613, 5096.974515127401, 5130.846074617767, 4735.100330937111, 4930.186519224288, 4981.501849814989, 4984.327115839315, 5002.799888004584, 4869.366982292279, 5021.924671130009, 5041.092603331289, 5093.134167191661, 5094.566961808139, 4962.8759281018265, 5017.046761115376, 5041.6722913010535, 5044.445111037856, 5110.361204849394], "mootools.html": [1264.2288204195443, 1368.302165895393, 1451.2018389885561, 1635.533872846239, 1650.0, 6254.343293954137, 6294.150289710888, 6901.0, 6997.405220556252, 7063.788086357411, 6930.0990871186805, 6933.687984040717, 7029.789106326818, 7117.679704413301, 7123.893141602867, 2023.7065625484297, 2045.253482478892, 2045.4886278430392, 2069.6998935154393, 2071.4717746974575, 2074.8547601667888, 2080.9063592138314, 2110.472381904524, 2133.2746866065536, 2137.1130980643015, 2039.1333683184662, 2055.629986602411, 2086.2280956046284, 2103.758067822205, 2112.5035616630157, 2016.41523958052, 2018.777934427212, 2026.189524190321, 2032.2175962254491, 2034.735484387035, 1991.8705284156483, 2031.4718173275055, 2111.873287602749, 2113.144176608476, 2128.8190503807195, 7124.643767811641, 7126.857462850766, 7168.103987001625, 7207.243239459886, 7216.530925489878, 4429.9114017719785, 4517.254652982254, 4538.432695913011, 4550.0, 4559.338895860082, 2682.852443115628, 2686.7984901132495, 2718.184544636601, 2733.016114198887, 2758.7930905181993, 770.8959290495767, 821.7206149909059, 821.7575815134489, 841.0370126205521, 843.0263046181609, 9404.294677899117, 9423.151916327564, 9425.528723563863, 9512.1439070484, 9528.523573821281, 4086.6322031017353, 4101.815418306123, 4157.646600039031, 4167.6874234432535, 4200.306949353384, 8178.754637360888, 8220.095789463154, 8227.341812654973, 8283.95858020706, 8300.252977232078, 4526.185286648435, 4534.183846907522, 4547.522510136454, 4588.632909367309, 4601.654875884322, 3659.6157403472253, 3745.1573395985683, 3996.1208534122447, 4098.897527561835, 4101.876943691635, 3295.143262751702, 3299.686529779667, 3351.2292172799903, 3373.5108409280515, 3378.44927080053, 1094.7974624694457, 1098.1599076706325, 1098.280626189847, 1102.6416414665266, 1111.9499622517005, 1186.976260474803, 1192.630284611773, 1199.7240634653904, 1217.5190799634095, 1217.719924417389, 6539.542232043711, 6587.80236592903, 6658.1011563438315, 6673.265940746514, 6704.597724136567, 383.7582323136462, 392.5132835284227, 393.9822707978148, 394.5226276205766, 394.54233089615906, 5155.32980712505, 5159.535641792257, 5171.663841850268, 5194.506521880416, 5243.0, 7825.726099586487, 7834.4124190685925, 7890.447668663139, 7959.403044771665, 8054.516728996279, 8134.511929284262, 8247.21651443124, 8321.08468068512, 8323.916760832435, 8352.66589336432, 6318.842028949313, 6733.427658648971, 6775.593464392152, 6825.624590647562, 6850.246472887979, 6477.676116194266, 6499.350064993463, 6551.672416379067, 6574.3754343337305, 6657.367550082734, 7321.926780732125, 7377.668004939684, 7382.335589796729, 7435.107787065586, 7479.0, 7491.662875170739, 7577.128630207597, 7630.923690763021, 7665.8466830661955, 7721.382289416945, 5599.580031497735, 5924.0, 6331.873362532816, 6342.175517182921, 6365.777197798055, 6251.624902505864, 6646.235682896336, 6646.700898459678, 6681.832954176184, 6684.832879177865, 6142.170806941006, 6148.9692551536955, 6222.719977601109, 6247.0, 6262.906056409066, 6012.398760124128, 6096.725647345968, 6138.109974053648, 6221.5333849960525, 6270.028145637433, 6241.157443745036, 6253.5622506424115, 6304.338044505261, 6356.2054743157105, 6377.93622063792, 5644.548436125182, 5657.434256574475, 5659.377468478382, 5718.742656580381, 5734.426557344233, 5516.14499752539, 5713.628614140068, 5774.740136693775, 5801.6519008859605, 5912.497437717842], "ext.html": [497.56960229401557, 497.8755311172207, 516.9353830771156, 520.307990372804, 528.859852139183, 35584.0, 36265.45601815968, 36668.633313666855, 36860.447093293624, 37110.443343349834, 37481.06297342561, 37703.811480942626, 37825.43261851074, 38109.80945095271, 38295.234095318076, 8017.478863873829, 8206.425550211488, 8220.177982201792, 8235.83528329436, 8239.052508961457, 8063.879041814348, 8216.424850260484, 8227.670893164266, 8233.917660823376, 8239.299659528948, 8102.351811855067, 8170.346372290202, 8179.304759095484, 8190.836183276331, 8213.671453141867, 8197.098319184885, 8212.0, 8279.213474719922, 8279.254867061933, 8425.620847061835, 7914.80212994674, 8050.919490805076, 8065.435419520636, 8075.596220189026, 8091.474054186459, 34622.30755384903, 35127.82436087803, 35199.0, 35245.295094098234, 35450.0, 2544.6691930048974, 2623.842569445839, 2635.5387807133866, 2662.8934842606272, 3107.8756849725983, 24530.264092077265, 24760.25719228426, 24934.625980610304, 25115.246542603752, 26080.217593472225, 2097.0668052716546, 2108.68369744538, 2113.260358874397, 2150.311900191939, 2229.7547269800307, 246804.0, 247807.0, 248135.0, 248346.0, 248700.75649621818, 50561.24158137631, 52753.736231319366, 55600.44399556034, 56040.71979640076, 59634.10548841771, 56271.155932661044, 56405.0, 57178.0, 57525.0, 57586.13620795608, 14883.255837208097, 14890.255487225595, 14921.880858935623, 15057.397704091933, 15090.094594324375, 11266.718332041764, 11361.375124368074, 11386.715332116763, 11388.829167562493, 11430.428478576037, 17723.0, 17949.910250448924, 18134.0, 18222.908885455487, 18374.17316220773, 7063.788086357417, 7274.127104747358, 7292.307230813064, 7328.890066649004, 7335.303146201102, 754.1741792736944, 818.6357071103421, 819.868820988639, 838.6100463284602, 939.6945992552311, 25256.242312730647, 25819.225423237334, 25970.610440843404, 26038.08866689657, 26101.73898261031, 905.9003509613938, 912.1061359867367, 922.077922077922, 950.1258841865363, 973.2943615878431, 13242.337883105805, 13275.800862987064, 13535.526256580972, 13579.52471663487, 13942.37259323333, 268158.0, 269203.0, 272958.0, 272990.0, 274121.0, 49278.26082608764, 49424.0, 49468.75265623649, 49712.25431618529, 49808.25287620688, 1228.4656174564093, 1254.0, 1254.667513109027, 1260.9117361784588, 1410.0904916328911, 26016.34959126037, 26282.4743505125, 26616.866915665298, 26674.0, 26698.19905402841, 43112.137757244054, 43270.56729432791, 43282.78358608187, 43504.564954350055, 43623.11088003079, 239478.0, 240806.0, 241951.0, 242168.0, 243098.0, 24722.876385617958, 25232.116875909254, 26999.460010800067, 27213.455730885667, 28478.0, 36864.0, 37239.441408378356, 37374.8131259342, 37404.0, 37826.810865945496, 30995.845020774752, 31302.686973130887, 31698.68301316957, 31956.52065218977, 32056.5191522132, 30996.22509437282, 31036.22409439782, 31290.0, 31494.21264468315, 31737.20656983594, 31032.379352412372, 31860.8406957973, 32106.678933211304, 32360.514592280662, 32372.0, 26542.469150617264, 27452.45095098047, 27492.45015099727, 27859.16422507328, 27947.86026069938, 21020.0, 21297.148114075884, 21315.786842132, 21468.248611298528, 21601.135954561643], "prototype.html": [280.0394646362975, 287.8201124297314, 293.09726043785156, 293.92945693033676, 294.76271601360895, 5759.366469688331, 5833.0, 5912.083627037805, 5928.288605367362, 5944.34612192659, 5733.340665823432, 5869.2369991901, 5876.4417380348905, 5881.882362352761, 5886.823395298137, 4451.844185453509, 4470.508244093147, 4483.677315192026, 4489.057297967431, 4493.101379724052, 4289.828406863738, 4323.2218200723855, 4401.80191891364, 4449.866504004885, 4509.6392288616835, 4397.934030989538, 4407.625351845097, 4415.911681766363, 4416.933745993812, 4432.246518091933, 4406.779661016953, 4422.159789639958, 4441.356003379492, 4449.332600109977, 4474.024773525602, 3742.925141497155, 3787.280416720842, 3795.430685397185, 3797.9240415191543, 3818.8281527331337, 5496.285482887239, 5684.488396044335, 5687.40282270364, 5688.033034384164, 5702.030654788696, 4899.583535399495, 4911.5088491150955, 4934.6792458490445, 4959.950400495985, 4979.751012449399, 6088.269407671108, 6117.143599896018, 6133.172021777048, 6139.815805525842, 6146.108814221912, 4005.35914253718, 4051.129007263423, 4056.6957478189256, 4058.1072164123843, 4071.0229544909007, 6266.905996410058, 6434.260060093103, 6439.742410303582, 6472.935270647327, 6477.4170324671, 4101.651359634465, 4104.589541045872, 4112.198121366365, 4134.793260337031, 4139.689523285766, 4198.097409057067, 4202.327627579572, 4210.052738133957, 4216.831326746896, 4229.0273237155625, 4834.6374021948495, 4928.137575924199, 4933.851984440473, 4962.354893863775, 4964.329815474937, 6138.232720909887, 6139.539534534928, 6144.662043587646, 6159.599626024294, 6171.105189747551, 1456.8980171388114, 1469.0744830756769, 1472.7054589082227, 1473.6021274256104, 1477.933492992818, 930.6835675870236, 938.2119020023214, 939.8872135343665, 947.5688561704408, 952.7951490429452, 5783.363829978699, 5790.0, 5842.415758424124, 5843.649381037151, 5845.766169353264, 6283.214598175228, 6316.968415157895, 6508.9349106508325, 6527.053577231275, 6534.640594767334, 5894.056950887837, 5903.3801450847905, 5927.762889484458, 5932.911006334908, 5954.225950626391, 3421.469672200813, 3455.4298540740497, 3484.4424892017155, 3514.10390350459, 3518.5601799775027, 6501.154849869581, 6624.701888415033, 6642.7342906284175, 6650.70071846768, 6680.632565208863, 6614.503912206507, 6623.668816559153, 6679.098321726602, 6702.530822842452, 6708.228553716288, 6636.435902948304, 6698.028785826125, 6708.127943367429, 6711.429528490133, 6711.597304161766, 6334.904976425265, 6419.871602568016, 6441.3880681335195, 6484.319146489551, 6512.47900167976, 6303.36966303366, 6312.705895291546, 6326.9683651581445, 6363.427291543783, 6381.87236255263, 6582.539222254396, 6679.398854102959, 6680.933190668031, 6681.198256209286, 6710.16122984627, 4056.9797151014054, 4096.774677392772, 4122.216778812016, 4165.104502531849, 4178.310578754593, 6416.486681065597, 6436.581622194542, 6439.291677915519, 6441.967790161207, 6443.2590252119735, 6248.375162483715, 6257.030160325156, 6258.43674069336, 6273.686315684289, 6278.686065696788, 6058.666773327509, 6256.7810126645345, 6258.0, 6259.6870156492905, 6272.341404152498, 6082.787102451393, 6088.117223002729, 6113.510919126548, 6125.724342404514, 6128.417800308964, 6218.626882387071, 6242.719077641426, 6255.624662520263, 6256.812295631138, 6257.998720204745, 5895.351511333835, 5988.6706231157705, 6114.113453549122, 6132.08018797184, 6132.35610260934], "yui.html": [575.8963386590415, 576.1214148423653, 620.0870315077984, 630.8612105336828, 647.873664635396, 12163.270203787768, 12370.876291237086, 12482.0, 12513.68715782106, 12550.372481375929, 10447.960643210321, 10491.475426228697, 10590.735231619194, 12016.218945768518, 12182.51269949201, 788.7870275025725, 791.956442395668, 806.0528878567688, 813.8046868751517, 814.767791179514, 792.5363662257586, 798.6406117247233, 806.0971711682923, 807.4670717326566, 810.4691427115249, 809.1625167951172, 817.9386546009043, 820.3519219816338, 822.3791037766478, 825.3603457320564, 815.1888870573788, 819.4100247821559, 820.024171236227, 820.2863508747398, 826.4751882554621, 604.3533419241413, 605.9606125601822, 612.0207667731594, 612.3447910735515, 612.7120253480857, 11076.0, 11215.271007384576, 11353.772924541463, 11416.257943233662, 11490.425478726114, 8609.526476043815, 8888.155625215593, 9421.670241541582, 9558.90441095587, 9566.0, 7856.371490280764, 7979.920200797976, 8031.919680803176, 8079.555624440653, 8094.392920530984, 2920.474314623367, 2923.985380073086, 2955.6157699499145, 2967.8516074196204, 3068.5243787213017, 39555.0, 42531.36202956958, 43088.56911430877, 43198.56801431977, 47070.058598828175, 7823.569703666353, 7840.882386764203, 8158.592070396457, 8202.507849529047, 8627.137286271449, 17133.0, 17143.14284285806, 17167.828321716624, 17196.0, 17267.309307627806, 6152.938470615326, 6216.906746398808, 6218.9378106218355, 6314.242290925118, 6356.586821856565, 3422.2299982504237, 3487.7907325560545, 3510.3330367230146, 3558.5018097466377, 3599.9100022499124, 2707.10665480391, 2737.7809775218334, 2764.7926405519665, 2764.7926405519665, 2771.4457108577963, 395.30426449449175, 395.5530250816559, 399.2434336931499, 420.6865884915757, 430.5371725395213, 392.66034879828743, 405.7808783257008, 418.51034289880914, 445.77711144427786, 480.9422869255712, 6620.635865027373, 6960.651967401711, 7537.736179233701, 7809.68761249555, 7851.05787305527, 523.5026724611635, 533.6051322021676, 540.8323419739893, 569.7749388991325, 575.473441800756, 3252.5121231815415, 3496.4405695088662, 3497.8076205808925, 3503.702185314226, 3571.142925697814, 54049.459505405226, 54789.0, 54958.17562736562, 55056.0, 55141.44858551363, 46178.307325390146, 47285.5271447288, 47783.761081194374, 47877.521224788004, 48436.27345589819, 35074.29851402958, 35574.822125889725, 36722.816385918435, 37703.24593508115, 38176.236475270336, 6889.0, 7039.964800175966, 7195.316444937723, 7444.441666874898, 7576.0, 32572.185695356857, 32697.0, 33343.66656333503, 33428.83285583654, 33436.498452523716, 39979.40030899481, 41707.16585668331, 43249.35125973176, 43295.0, 43602.0, 6806.285340039422, 6864.24493305726, 6930.5148639594745, 7043.436525077879, 7106.324899134574, 9518.476483793458, 9874.605015799574, 9927.106560409598, 10113.14038306752, 10290.434026128634, 9286.95356523213, 9510.95244523773, 9792.314537982273, 10028.197744180303, 10230.846537301797, 9549.379290346105, 9784.217262619115, 9852.162566181954, 9861.260405469475, 10278.794424111626, 8682.044975052866, 8739.03870574249, 8778.0, 8907.0, 9095.863562046707, 7988.800279993046, 8038.115807261313, 8092.6762929482165, 8229.382796290183, 9001.504917229615, 7338.412926965723, 7592.81017974555, 8018.278354948083, 8054.476459030145, 8292.792680182802]}, "summary": {"lowerIsBetter": false, "suite": 5960.161730384407, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5836.7155806067, "unit": "ms", "value": 5836.7155806067}, "dojo.html": {"lowerIsBetter": false, "filtered": 4792.256178398163, "unit": "ms", "value": 4792.256178398163}, "mootools.html": {"lowerIsBetter": false, "filtered": 3961.923958592419, "unit": "ms", "value": 3961.923958592419}, "ext.html": {"lowerIsBetter": false, "filtered": 16405.158336908444, "unit": "ms", "value": 16405.158336908444}, "prototype.html": {"lowerIsBetter": false, "filtered": 4595.553085658546, "unit": "ms", "value": 4595.553085658546}, "yui.html": {"lowerIsBetter": false, "filtered": 5365.077462204284, "unit": "ms", "value": 5365.077462204284}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0026.e"}, "testrun": {"date": 1447715709, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116135636", "branch": "Mozilla-Inbound", "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4"}}, {"talos_counters": {}, "results": {"audio-dft": [187.0, 185.0, 192.0, 197.0, 196.0, 186.0, 186.0, 185.0, 195.0, 195.0], "ai-astar": [109.0, 105.0, 113.0, 117.0, 119.0, 134.0, 127.0, 128.0, 125.0, 121.0], "imaging-gaussian-blur": [136.0, 136.0, 142.0, 134.0, 136.0, 136.0, 141.0, 136.0, 142.0, 142.0], "audio-beat-detection": [173.0, 155.0, 177.0, 187.0, 154.0, 172.0, 163.0, 150.0, 190.0, 155.0], "json-stringify-tinderbox": [75.0, 81.0, 81.0, 83.0, 83.0, 84.0, 82.0, 81.0, 81.0, 82.0], "stanford-crypto-pbkdf2": [162.0, 179.0, 180.0, 164.0, 173.0, 168.0, 190.0, 179.0, 173.0, 163.0], "json-parse-financial": [66.0, 70.0, 72.0, 74.0, 76.0, 75.0, 74.0, 82.0, 73.0, 76.0], "stanford-crypto-sha256-iterative": [77.0, 80.0, 81.0, 82.0, 84.0, 84.0, 83.0, 87.0, 79.0, 81.0], "audio-fft": [74.0, 82.0, 86.0, 91.0, 130.0, 78.0, 78.0, 98.0, 80.0, 128.0], "imaging-darkroom": [149.0, 149.0, 142.0, 151.0, 149.0, 149.0, 143.0, 150.0, 150.0, 144.0], "stanford-crypto-ccm": [156.0, 151.0, 147.0, 154.0, 148.0, 160.0, 158.0, 150.0, 147.0, 151.0], "audio-oscillator": [97.0, 99.0, 148.0, 98.0, 101.0, 100.0, 143.0, 105.0, 106.0, 148.0], "stanford-crypto-aes": [95.0, 98.0, 103.0, 101.0, 103.0, 104.0, 104.0, 102.0, 102.0, 99.0], "imaging-desaturate": [122.0, 113.0, 112.0, 121.0, 124.0, 118.0, 112.0, 108.0, 122.0, 122.0]}, "summary": {"lowerIsBetter": true, "suite": 1751.1999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 92.5, "unit": "ms", "value": 92.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 173.1, "unit": "ms", "value": 173.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 167.6, "unit": "ms", "value": 167.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 152.2, "unit": "ms", "value": 152.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.6, "unit": "ms", "value": 147.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.8, "unit": "ms", "value": 73.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 114.5, "unit": "ms", "value": 114.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 119.8, "unit": "ms", "value": 119.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 190.4, "unit": "ms", "value": 190.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 81.8, "unit": "ms", "value": 81.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 81.3, "unit": "ms", "value": 81.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 138.1, "unit": "ms", "value": 138.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 101.1, "unit": "ms", "value": 101.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 117.4, "unit": "ms", "value": 117.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0026.e"}, "testrun": {"date": 1447715709, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116135636", "branch": "Mozilla-Inbound", "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [219.4426157559798], "Encrypt": [352.98270384751146], "NavierStokes": [6416.666666666667], "Decrypt": [6622.516556291391], "Splay": [678.8866259334691], "Richards": [177.1793054571226], "RegExp": [34152.542372881355], "Earley": [891.3624220837044], "Boyer": [15074.626865671642], "RayTrace": [1267.427122940431]}, "summary": {"lowerIsBetter": false, "suite": 17529.50406149458, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 301.29972600000013, "unit": "score", "value": 301.29972600000013}, "Encrypt": {"lowerIsBetter": false, "filtered": 754.0907730000001, "unit": "score", "value": 754.0907730000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 231.2727272727272, "unit": "score", "value": 231.2727272727272}, "Decrypt": {"lowerIsBetter": false, "filtered": 40.19333100000003, "unit": "score", "value": 40.19333100000003}, "Splay": {"lowerIsBetter": false, "filtered": 120.03624300000007, "unit": "score", "value": 120.03624300000007}, "RegExp": {"lowerIsBetter": false, "filtered": 26.67400248138959, "unit": "score", "value": 26.67400248138959}, "Richards": {"lowerIsBetter": false, "filtered": 199.24448800000002, "unit": "score", "value": 199.24448800000002}, "Earley": {"lowerIsBetter": false, "filtered": 747.6902587412585, "unit": "score", "value": 747.6902587412585}, "Boyer": {"lowerIsBetter": false, "filtered": 44.21091188118815, "unit": "score", "value": 44.21091188118815}, "RayTrace": {"lowerIsBetter": false, "filtered": 583.8513209999999, "unit": "score", "value": 583.8513209999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0026.e"}, "testrun": {"date": 1447715709, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116135636", "branch": "Mozilla-Inbound", "revision": "6f40e9b622236da96a2c10e57b95118acc85ecd4"}}] 15:35:23 INFO - RETURN: dromaeo_css: 5960.16 15:35:23 INFO - RETURN: kraken: 1751.20 15:35:23 INFO - RETURN: v8_7: 17529.50 15:35:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "17529.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1751.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5960.16"}}} 15:35:23 INFO - Return code: 0 15:35:23 INFO - # TBPL SUCCESS # 15:35:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:35:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:35:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:35:23 INFO - 2015-11-16 15:35:23.274 screenresolution[1668:10868] starting screenresolution argv=screenresolution get 15:35:23 INFO - 2015-11-16 15:35:23.277 screenresolution[1668:10868] Display 0: 1600x1200x32@60 15:35:23 INFO - 2015-11-16 15:35:23.284 screenresolution[1669:10871] starting screenresolution argv=screenresolution list 15:35:23 INFO - Available Modes on Display 0 15:35:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:35:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:35:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:35:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:35:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:35:23 INFO - Intel HD Graphics 3000: 15:35:23 INFO - Chipset Model: Intel HD Graphics 3000 15:35:23 INFO - Type: GPU 15:35:23 INFO - Bus: Built-In 15:35:23 INFO - VRAM (Total): 512 MB 15:35:23 INFO - VRAM (Dynamic, Max): 10 15:35:23 INFO - Vendor: Intel (0x8086) 15:35:23 INFO - Device ID: 0x0116 15:35:23 INFO - Revision ID: 0x0009 15:35:23 INFO - Displays: 15:35:23 INFO - Display: 15:35:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:35:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:35:23 INFO - Display Serial Number: 1600x1200 60 15:35:23 INFO - Main Display: Yes 15:35:23 INFO - Mirror: Off 15:35:23 INFO - Online: Yes 15:35:23 INFO - Rotation: Supported 15:35:23 INFO - Return code: 0 15:35:23 INFO - Running post-action listener: _resource_record_post_action 15:35:23 INFO - Running post-run listener: _resource_record_post_run 15:35:24 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 41604096; Write bytes: 692570112; Read time: 5285; Write time: 59226 15:35:24 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 339094016; Write bytes: 335005696; Read time: 35212; Write time: 5924 15:35:24 INFO - run-tests - Wall time: 1215s; CPU: 30.0%; Read bytes: 39773184; Write bytes: 346357760; Read time: 4859; Write time: 52509 15:35:24 INFO - Running post-run listener: _upload_blobber_files 15:35:24 INFO - Blob upload gear active. 15:35:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:35:24 INFO - Copying logs to upload dir... 15:35:24 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.831246 ========= master_lag: 2.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-16 15:35:27.429299) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:35:27.433103) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010072 build_url: 'https://queue.taskcluster.net/v1/task/f3YieWIeREuSanPM7bUT8g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:35:27.469129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:35:27.469542) ========= 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.WrAFzflvdO/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.uJTknfjb8z/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.005222 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:35:27.518881) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:35:27.519319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:35:27.519927) ========= ========= Total master_lag: 3.22 =========