builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0107 starttime: 1447548385.48 results: success (0) buildid: 20151114144431 builduid: b332709026104b77a8889c1c8cd3b7f3 revision: 5fb6f8b316ca76a5a4c47464900eaed2774d844f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:25.480149) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:25.480802) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:25.481137) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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.006269 basedir: '/builds/slave/test' ========= master_lag: 0.59 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.072527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.072899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.095645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.096003) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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.024463 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.144433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.144763) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.145660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.145983) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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-14 16:46:26-- 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% 1.26G=0s 2015-11-14 16:46:26 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.323510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.323888) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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.066117 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.405537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.405906) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fb6f8b316ca76a5a4c47464900eaed2774d844f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5fb6f8b316ca76a5a4c47464900eaed2774d844f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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-14 16:46:26,498 truncating revision to first 12 chars 2015-11-14 16:46:26,498 Setting DEBUG logging. 2015-11-14 16:46:26,498 attempt 1/10 2015-11-14 16:46:26,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fb6f8b316ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 16:46:26,758 unpacking tar archive at: fx-team-5fb6f8b316ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.954211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.954527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.967789) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.968100) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:46:26.968551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-11-14 16:46:26.968895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:46:27 INFO - MultiFileLogger online at 20151114 16:46:27 in /builds/slave/test 16:46:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:46:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:27 INFO - {'append_to_log': False, 16:46:27 INFO - 'base_work_dir': '/builds/slave/test', 16:46:27 INFO - 'blob_upload_branch': 'Fx-Team', 16:46:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:27 INFO - 'branch': 'Fx-Team', 16:46:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:27 INFO - 'config_files': ('talos/mac_config.py',), 16:46:27 INFO - 'default_actions': ('clobber', 16:46:27 INFO - 'read-buildbot-config', 16:46:27 INFO - 'download-and-extract', 16:46:27 INFO - 'populate-webroot', 16:46:27 INFO - 'create-virtualenv', 16:46:27 INFO - 'install', 16:46:27 INFO - 'run-tests'), 16:46:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:27 INFO - 'download_minidump_stackwalk': True, 16:46:27 INFO - 'download_symbols': 'ondemand', 16:46:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:27 INFO - 'installer_path': 'installer.exe', 16:46:27 INFO - 'log_level': 'info', 16:46:27 INFO - 'log_name': 'talos', 16:46:27 INFO - 'log_to_console': True, 16:46:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:46:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:46:27 INFO - 'opt_config_files': (), 16:46:27 INFO - 'pip_index': False, 16:46:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:27 INFO - 'cmd': ('bash', 16:46:27 INFO - '-c', 16:46:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:27 INFO - 'enabled': True, 16:46:27 INFO - 'halt_on_failure': False, 16:46:27 INFO - 'name': 'check_screen_resolution'},), 16:46:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:27 INFO - 'cmd': ('bash', 16:46:27 INFO - '-c', 16:46:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:27 INFO - 'enabled': True, 16:46:27 INFO - 'halt_on_failure': False, 16:46:27 INFO - 'name': 'check_screen_resolution'},), 16:46:27 INFO - 'run_cmd_checks_enabled': True, 16:46:27 INFO - 'sps_profile': False, 16:46:27 INFO - 'sps_profile_interval': 0, 16:46:27 INFO - 'suite': 'dromaeojs-e10s', 16:46:27 INFO - 'system_bits': '64', 16:46:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:27 INFO - 'title': 't-yosemite-r5-0107', 16:46:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:27 INFO - 'use_talos_json': True, 16:46:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:27 INFO - 'work_dir': 'build'} 16:46:27 INFO - ##### 16:46:27 INFO - ##### Running clobber step. 16:46:27 INFO - ##### 16:46:27 INFO - Running pre-action listener: _resource_record_pre_action 16:46:27 INFO - Running main action method: clobber 16:46:27 INFO - rmtree: /builds/slave/test/build 16:46:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:30 INFO - Running post-action listener: _resource_record_post_action 16:46:30 INFO - ##### 16:46:30 INFO - ##### Running read-buildbot-config step. 16:46:30 INFO - ##### 16:46:30 INFO - Running pre-action listener: _resource_record_pre_action 16:46:30 INFO - Running main action method: read_buildbot_config 16:46:30 INFO - Using buildbot properties: 16:46:30 INFO - { 16:46:30 INFO - "properties": { 16:46:30 INFO - "buildnumber": 46, 16:46:30 INFO - "product": "firefox", 16:46:30 INFO - "script_repo_revision": "production", 16:46:30 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 16:46:30 INFO - "repository": "", 16:46:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 16:46:30 INFO - "buildid": "20151114144431", 16:46:30 INFO - "slavename": "t-yosemite-r5-0107", 16:46:30 INFO - "pgo_build": "False", 16:46:30 INFO - "basedir": "/builds/slave/test", 16:46:30 INFO - "project": "", 16:46:30 INFO - "platform": "yosemite", 16:46:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:46:30 INFO - "slavebuilddir": "test", 16:46:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:46:30 INFO - "branch": "fx-team", 16:46:30 INFO - "repo_path": "integration/fx-team", 16:46:30 INFO - "stage_platform": "macosx64", 16:46:30 INFO - "builduid": "b332709026104b77a8889c1c8cd3b7f3", 16:46:30 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 16:46:30 INFO - }, 16:46:30 INFO - "sourcestamp": { 16:46:30 INFO - "repository": "", 16:46:30 INFO - "hasPatch": false, 16:46:30 INFO - "project": "", 16:46:30 INFO - "branch": "fx-team-macosx64-talos", 16:46:30 INFO - "changes": [ 16:46:30 INFO - { 16:46:30 INFO - "category": null, 16:46:30 INFO - "files": [ 16:46:30 INFO - { 16:46:30 INFO - "url": null, 16:46:30 INFO - "name": "https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:46:30 INFO - } 16:46:30 INFO - ], 16:46:30 INFO - "repository": "", 16:46:30 INFO - "rev": "5fb6f8b316ca76a5a4c47464900eaed2774d844f", 16:46:30 INFO - "who": "philringnalda@gmail.com", 16:46:30 INFO - "when": 1447548330, 16:46:30 INFO - "number": 6662856, 16:46:30 INFO - "comments": "Bug 1185403 - Disable browser/components/preferences/in-content/tests/browser_healthreport.js for frequent failures", 16:46:30 INFO - "project": "", 16:46:30 INFO - "at": "Sat 14 Nov 2015 16:45:30", 16:46:30 INFO - "branch": "fx-team-macosx64-talos", 16:46:30 INFO - "revlink": "", 16:46:30 INFO - "properties": [ 16:46:30 INFO - [ 16:46:30 INFO - "buildid", 16:46:30 INFO - "20151114144431", 16:46:30 INFO - "Change" 16:46:30 INFO - ], 16:46:30 INFO - [ 16:46:30 INFO - "builduid", 16:46:30 INFO - "b332709026104b77a8889c1c8cd3b7f3", 16:46:30 INFO - "Change" 16:46:30 INFO - ], 16:46:30 INFO - [ 16:46:30 INFO - "pgo_build", 16:46:30 INFO - "False", 16:46:30 INFO - "Change" 16:46:30 INFO - ] 16:46:30 INFO - ], 16:46:30 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 16:46:30 INFO - } 16:46:30 INFO - ], 16:46:30 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 16:46:30 INFO - } 16:46:30 INFO - } 16:46:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:46:30 INFO - Running post-action listener: _resource_record_post_action 16:46:30 INFO - ##### 16:46:30 INFO - ##### Running download-and-extract step. 16:46:30 INFO - ##### 16:46:30 INFO - Running pre-action listener: _resource_record_pre_action 16:46:30 INFO - Running main action method: download_and_extract 16:46:30 INFO - mkdir: /builds/slave/test/build/tests 16:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:30 INFO - https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/test_packages.json 16:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/test_packages.json 16:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:46:35 INFO - Downloaded 1149 bytes. 16:46:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:46:35 INFO - Using the following test package requirements: 16:46:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:46:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:46:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'jsshell-mac.zip'], 16:46:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:46:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:46:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:46:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:46:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:46:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:46:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:46:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:46:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:46:35 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')]} 16:46:35 INFO - https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:36 INFO - Downloaded 17464158 bytes. 16:46: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 16:46:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:46:41 INFO - Return code: 0 16:46:41 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 16:46:41 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')]} 16:46:41 INFO - https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:45 INFO - Downloaded 17464158 bytes. 16:46:45 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 16:46:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:46:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:46:52 INFO - Return code: 0 16:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:52 INFO - https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:53 INFO - Downloaded 11131693 bytes. 16:46:53 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 16:46:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:46:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:46:54 INFO - Return code: 0 16:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:54 INFO - https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vPuJzxHWSvWnKT2De8NPTQ/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 16:46:57 INFO - Downloaded 108664023 bytes. 16:46:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:46:57 INFO - mkdir: /builds/slave/test/properties 16:46:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:46:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:46:57 INFO - Contents: 16:46:57 INFO - build_url:https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:46:57 INFO - Running post-action listener: _resource_record_post_action 16:46:57 INFO - Running post-action listener: set_extra_try_arguments 16:46:57 INFO - ##### 16:46:57 INFO - ##### Running populate-webroot step. 16:46:57 INFO - ##### 16:46:57 INFO - Running pre-action listener: _resource_record_pre_action 16:46:57 INFO - Running main action method: populate_webroot 16:46:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:46:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:46:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:46:57 INFO - '../fennec_ids.txt'], 16:46:57 INFO - 'tests': ['tcheck2']}, 16:46:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:46:57 INFO - '--tppagecycles', 16:46:57 INFO - '7'], 16:46:57 INFO - 'tests': ['tsvgm']}}, 16:46:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:46:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:46:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:46:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:46:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'tests': ['damp', 'tps']}, 16:46:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['damp', 'tps']}, 16:46:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:46:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:46:57 INFO - 'other': {'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'other_l64': {'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:46:57 INFO - 'ts_paint', 16:46:57 INFO - 'tpaint', 16:46:57 INFO - 'sessionrestore', 16:46:57 INFO - 'sessionrestore_no_auto_restore']}, 16:46:57 INFO - 'svgr': {'tests': ['tsvgx', 16:46:57 INFO - 'tsvgr_opacity', 16:46:57 INFO - 'tart', 16:46:57 INFO - 'tscrollx', 16:46:57 INFO - 'cart']}, 16:46:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['tsvgx', 16:46:57 INFO - 'tsvgr_opacity', 16:46:57 INFO - 'tart', 16:46:57 INFO - 'tscrollx', 16:46:57 INFO - 'cart']}, 16:46:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'tests': ['tp5o']}, 16:46:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'talos_options': ['--e10s'], 16:46:57 INFO - 'tests': ['tp5o']}, 16:46:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'talos_options': ['--xperf_path', 16:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:57 INFO - 'tests': ['tp5n']}, 16:46:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:57 INFO - 'talos_options': ['--e10s', 16:46:57 INFO - '--xperf_path', 16:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:57 INFO - 'tests': ['tp5n']}}, 16:46:57 INFO - 'talos.zip': {'path': '', 16:46:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:46:57 INFO - Running post-action listener: _resource_record_post_action 16:46:57 INFO - ##### 16:46:57 INFO - ##### Running create-virtualenv step. 16:46:57 INFO - ##### 16:46:57 INFO - Running pre-action listener: _resource_record_pre_action 16:46:57 INFO - Running main action method: create_virtualenv 16:46:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:46:57 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 16:46:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:46:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:46:58 INFO - Using real prefix '/tools/python27' 16:46:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:46:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:02 INFO - Installing pip.................done. 16:47:02 INFO - Return code: 0 16:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:02 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:02 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 16:47:02 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 16:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:02 INFO - 'HOME': '/Users/cltbld', 16:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:02 INFO - 'LOGNAME': 'cltbld', 16:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:02 INFO - 'MOZ_NO_REMOTE': '1', 16:47:02 INFO - 'NO_EM_RESTART': '1', 16:47:02 INFO - 'PAGER': '/bin/cat', 16:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:02 INFO - 'PWD': '/builds/slave/test', 16:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:02 INFO - 'SHELL': '/bin/bash', 16:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:02 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:02 INFO - 'USER': 'cltbld', 16:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:02 INFO - 'XPC_FLAGS': '0x0', 16:47:02 INFO - 'XPC_SERVICE_NAME': '0', 16:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:03 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 16:47:03 INFO - Cleaning up... 16:47:03 INFO - Return code: 0 16:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:03 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:03 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 16:47:03 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 16:47:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:03 INFO - 'HOME': '/Users/cltbld', 16:47:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:03 INFO - 'LOGNAME': 'cltbld', 16:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:03 INFO - 'MOZ_NO_REMOTE': '1', 16:47:03 INFO - 'NO_EM_RESTART': '1', 16:47:03 INFO - 'PAGER': '/bin/cat', 16:47:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:03 INFO - 'PWD': '/builds/slave/test', 16:47:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:03 INFO - 'SHELL': '/bin/bash', 16:47:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:03 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:03 INFO - 'USER': 'cltbld', 16:47:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:03 INFO - 'XPC_FLAGS': '0x0', 16:47:03 INFO - 'XPC_SERVICE_NAME': '0', 16:47:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:03 INFO - Downloading/unpacking psutil>=0.7.1 16:47:03 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 16:47:03 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 16:47:03 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 16:47:03 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 16:47:03 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 16:47:03 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 16:47:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:06 INFO - Installing collected packages: psutil 16:47:06 INFO - Running setup.py install for psutil 16:47:06 INFO - building 'psutil._psutil_osx' extension 16:47: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:47:08 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 16:47:08 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 16:47:08 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 16:47:09 INFO - building 'psutil._psutil_posix' extension 16:47:09 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 16:47:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:47:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:47:09 INFO - ^ 16:47:09 INFO - 1 warning generated. 16:47:09 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 16:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:09 INFO - Successfully installed psutil 16:47:09 INFO - Cleaning up... 16:47:09 INFO - Return code: 0 16:47:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:09 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:09 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 16:47:09 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 16:47:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:09 INFO - 'HOME': '/Users/cltbld', 16:47:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:09 INFO - 'LOGNAME': 'cltbld', 16:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:09 INFO - 'MOZ_NO_REMOTE': '1', 16:47:09 INFO - 'NO_EM_RESTART': '1', 16:47:09 INFO - 'PAGER': '/bin/cat', 16:47:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:09 INFO - 'PWD': '/builds/slave/test', 16:47:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:09 INFO - 'SHELL': '/bin/bash', 16:47:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:09 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:09 INFO - 'USER': 'cltbld', 16:47:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:09 INFO - 'XPC_FLAGS': '0x0', 16:47:09 INFO - 'XPC_SERVICE_NAME': '0', 16:47:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:47:09 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 16:47:09 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 16:47:09 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 16:47:09 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 16:47:09 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 16:47:09 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 16:47:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:47:12 INFO - Installing collected packages: mozsystemmonitor 16:47:12 INFO - Running setup.py install for mozsystemmonitor 16:47:12 INFO - Successfully installed mozsystemmonitor 16:47:12 INFO - Cleaning up... 16:47:12 INFO - Return code: 0 16:47:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:12 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')]} 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:12 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')]} 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:12 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:12 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 16:47:12 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 16:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:12 INFO - 'HOME': '/Users/cltbld', 16:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:12 INFO - 'LOGNAME': 'cltbld', 16:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:12 INFO - 'MOZ_NO_REMOTE': '1', 16:47:12 INFO - 'NO_EM_RESTART': '1', 16:47:12 INFO - 'PAGER': '/bin/cat', 16:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:12 INFO - 'PWD': '/builds/slave/test', 16:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:12 INFO - 'SHELL': '/bin/bash', 16:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:12 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:12 INFO - 'USER': 'cltbld', 16:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:12 INFO - 'XPC_FLAGS': '0x0', 16:47:12 INFO - 'XPC_SERVICE_NAME': '0', 16:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:13 INFO - Downloading/unpacking blobuploader==1.2.4 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:15 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:15 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 16:47:15 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 16:47:15 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 16:47:15 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 16:47:15 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 16:47:15 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 16:47:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:16 INFO - Downloading docopt-0.6.1.tar.gz 16:47:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:17 INFO - Running setup.py install for blobuploader 16:47:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:17 INFO - Running setup.py install for requests 16:47:17 INFO - Running setup.py install for docopt 16:47:18 INFO - Successfully installed blobuploader requests docopt 16:47:18 INFO - Cleaning up... 16:47:18 INFO - Return code: 0 16:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:18 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 16:47:18 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 16:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:18 INFO - 'HOME': '/Users/cltbld', 16:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:18 INFO - 'LOGNAME': 'cltbld', 16:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:18 INFO - 'MOZ_NO_REMOTE': '1', 16:47:18 INFO - 'NO_EM_RESTART': '1', 16:47:18 INFO - 'PAGER': '/bin/cat', 16:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:18 INFO - 'PWD': '/builds/slave/test', 16:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:18 INFO - 'SHELL': '/bin/bash', 16:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:18 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:18 INFO - 'USER': 'cltbld', 16:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:18 INFO - 'XPC_FLAGS': '0x0', 16:47:18 INFO - 'XPC_SERVICE_NAME': '0', 16:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:18 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-OVX4TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:18 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-iIxKUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:18 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-NK8XpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:18 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-WWNe57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-pIEkIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-Ggm4nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-w4kRHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-YSvG2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-N7E6V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-2syTy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-oSN7v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:19 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-KJa8M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:20 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-g8MLYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:20 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-EGT6vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:20 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-DfJii4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:20 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-5UOFHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:20 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-MPZOOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:20 INFO - Running setup.py install for manifestparser 16:47:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:20 INFO - Running setup.py install for mozcrash 16:47:21 INFO - Running setup.py install for mozdebug 16:47:21 INFO - Running setup.py install for mozdevice 16:47:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozfile 16:47:21 INFO - Running setup.py install for mozhttpd 16:47:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozinfo 16:47:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:21 INFO - Running setup.py install for mozInstall 16:47:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Running setup.py install for mozleak 16:47:22 INFO - Running setup.py install for mozlog 16:47:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Running setup.py install for moznetwork 16:47:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:22 INFO - Running setup.py install for mozprocess 16:47:22 INFO - Running setup.py install for mozprofile 16:47:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozrunner 16:47:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozscreenshot 16:47:23 INFO - Running setup.py install for moztest 16:47:23 INFO - Running setup.py install for mozversion 16:47:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:23 INFO - Cleaning up... 16:47:23 INFO - Return code: 0 16:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:23 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:23 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 16:47:23 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 16:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:23 INFO - 'HOME': '/Users/cltbld', 16:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:23 INFO - 'LOGNAME': 'cltbld', 16:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:23 INFO - 'MOZ_NO_REMOTE': '1', 16:47:23 INFO - 'NO_EM_RESTART': '1', 16:47:23 INFO - 'PAGER': '/bin/cat', 16:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:23 INFO - 'PWD': '/builds/slave/test', 16:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:23 INFO - 'SHELL': '/bin/bash', 16:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:23 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:23 INFO - 'USER': 'cltbld', 16:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:23 INFO - 'XPC_FLAGS': '0x0', 16:47:23 INFO - 'XPC_SERVICE_NAME': '0', 16:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-gzBB1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-eB7hio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-McEZGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-Z5zKaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-B4Us3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-HsAmvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:24 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)) 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:24 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-5uq6wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-LIrwql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-IOXJ_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-SsR922-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-7HJhjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-NeMvHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-EvnB6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:25 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-Y7OVGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:26 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)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:26 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-jxw95q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:26 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)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:26 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-848qeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:26 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)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:26 INFO - Running setup.py (path:/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/pip-JbKh1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:26 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)) 16:47:26 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)) 16:47:26 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)) 16:47:26 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)) 16:47:26 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)) 16:47:26 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)) 16:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:26 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 16:47:26 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 16:47:26 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 16:47:26 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 16:47:26 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 16:47:26 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 16:47:29 INFO - Downloading blessings-1.5.1.tar.gz 16:47:29 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 16:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:29 INFO - Installing collected packages: blessings 16:47:29 INFO - Running setup.py install for blessings 16:47:29 INFO - Successfully installed blessings 16:47:29 INFO - Cleaning up... 16:47:29 INFO - Return code: 0 16:47:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:29 INFO - Reading from file tmpfile_stdout 16:47:29 INFO - Current package versions: 16:47:29 INFO - blessings == 1.5.1 16:47:29 INFO - blobuploader == 1.2.4 16:47:29 INFO - docopt == 0.6.1 16:47:29 INFO - manifestparser == 1.1 16:47:29 INFO - mozInstall == 1.12 16:47:29 INFO - mozcrash == 0.16 16:47:29 INFO - mozdebug == 0.1 16:47:29 INFO - mozdevice == 0.47 16:47:29 INFO - mozfile == 1.2 16:47:29 INFO - mozhttpd == 0.7 16:47:29 INFO - mozinfo == 0.9 16:47:29 INFO - mozleak == 0.1 16:47:29 INFO - mozlog == 3.0 16:47:29 INFO - moznetwork == 0.27 16:47:29 INFO - mozprocess == 0.22 16:47:29 INFO - mozprofile == 0.27 16:47:29 INFO - mozrunner == 6.11 16:47:29 INFO - mozscreenshot == 0.1 16:47:29 INFO - mozsystemmonitor == 0.0 16:47:29 INFO - moztest == 0.7 16:47:29 INFO - mozversion == 1.4 16:47:29 INFO - psutil == 3.1.1 16:47:29 INFO - requests == 1.2.3 16:47:29 INFO - wsgiref == 0.1.2 16:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:29 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')]} 16:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:29 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')]} 16:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:29 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 0x1091d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe921f02a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, '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.wAMNNWZ4on/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.7zRru1Qp59/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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 16:47:29 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 16:47:29 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 16:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:29 INFO - 'HOME': '/Users/cltbld', 16:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:29 INFO - 'LOGNAME': 'cltbld', 16:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:29 INFO - 'MOZ_NO_REMOTE': '1', 16:47:29 INFO - 'NO_EM_RESTART': '1', 16:47:29 INFO - 'PAGER': '/bin/cat', 16:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:29 INFO - 'PWD': '/builds/slave/test', 16:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:29 INFO - 'SHELL': '/bin/bash', 16:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:47:29 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:29 INFO - 'USER': 'cltbld', 16:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:29 INFO - 'XPC_FLAGS': '0x0', 16:47:29 INFO - 'XPC_SERVICE_NAME': '0', 16:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 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)) 16:47:30 INFO - Cleaning up... 16:47:30 INFO - Return code: 0 16:47:30 INFO - Running post-action listener: _resource_record_post_action 16:47:30 INFO - Running post-action listener: _start_resource_monitoring 16:47:30 INFO - Starting resource monitoring. 16:47:30 INFO - ##### 16:47:30 INFO - ##### Running install step. 16:47:30 INFO - ##### 16:47:30 INFO - Running pre-action listener: _resource_record_pre_action 16:47:30 INFO - Running main action method: install 16:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:30 INFO - Reading from file tmpfile_stdout 16:47:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:30 INFO - Reading from file tmpfile_stdout 16:47:30 INFO - Output received: 16:47:30 INFO - Usage: mozinstall [options] installer 16:47:30 INFO - Options: 16:47:30 INFO - -h, --help show this help message and exit 16:47:30 INFO - -d DEST, --destination=DEST 16:47:30 INFO - Directory to install application into. [default: 16:47:30 INFO - "/builds/slave/test"] 16:47:30 INFO - --app=APP Application being installed. [default: firefox] 16:47:30 INFO - mkdir: /builds/slave/test/build/application 16:47:30 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'] 16:47:30 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 16:48:10 INFO - Reading from file tmpfile_stdout 16:48:10 INFO - Output received: 16:48:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:48:10 INFO - Running post-action listener: _resource_record_post_action 16:48:10 INFO - ##### 16:48:10 INFO - ##### Running run-tests step. 16:48:10 INFO - ##### 16:48:10 INFO - Running pre-action listener: _resource_record_pre_action 16:48:10 INFO - Running main action method: run_tests 16:48:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:48:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:48:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:48:10 INFO - 2015-11-14 16:48:10.586 screenresolution[1629:7704] starting screenresolution argv=screenresolution get 16:48:10 INFO - 2015-11-14 16:48:10.590 screenresolution[1629:7704] Display 0: 1600x1200x32@60 16:48:10 INFO - 2015-11-14 16:48:10.596 screenresolution[1630:7706] starting screenresolution argv=screenresolution list 16:48:10 INFO - Available Modes on Display 0 16:48:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:48:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:48:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:48:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:48:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:48:10 INFO - Intel HD Graphics 3000: 16:48:10 INFO - Chipset Model: Intel HD Graphics 3000 16:48:10 INFO - Type: GPU 16:48:10 INFO - Bus: Built-In 16:48:10 INFO - VRAM (Total): 512 MB 16:48:10 INFO - VRAM (Dynamic, Max): 10 16:48:10 INFO - Vendor: Intel (0x8086) 16:48:10 INFO - Device ID: 0x0116 16:48:10 INFO - Revision ID: 0x0009 16:48:10 INFO - Displays: 16:48:10 INFO - Display: 16:48:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:48:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:48:10 INFO - Display Serial Number: 1600x1200 60 16:48:10 INFO - Main Display: Yes 16:48:10 INFO - Mirror: Off 16:48:10 INFO - Online: Yes 16:48:10 INFO - Rotation: Supported 16:48:10 INFO - Return code: 0 16:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:48:10 INFO - Python 2.7.3 16:48:10 INFO - Return code: 0 16:48:10 INFO - grabbing minidump binary from tooltool 16:48: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')]} 16:48:10 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 0x1090f79f0>, '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 0x108e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:48:10 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 16:48:10 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 16:48:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:11 INFO - Return code: 0 16:48:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:48:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:48:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:48:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:48:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0107', '--webServer', 'localhost'] in /builds/slave/test/build 16:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0107 --webServer localhost 16:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAMNNWZ4on/Render', 16:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:11 INFO - 'HOME': '/Users/cltbld', 16:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:11 INFO - 'LOGNAME': 'cltbld', 16:48:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:48:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:11 INFO - 'MOZ_NO_REMOTE': '1', 16:48:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:48:11 INFO - 'NO_EM_RESTART': '1', 16:48:11 INFO - 'PAGER': '/bin/cat', 16:48:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:11 INFO - 'PWD': '/builds/slave/test', 16:48:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:11 INFO - 'SHELL': '/bin/bash', 16:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7zRru1Qp59/Listeners', 16:48:11 INFO - 'TMPDIR': '/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/', 16:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:11 INFO - 'USER': 'cltbld', 16:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:11 INFO - 'XPC_FLAGS': '0x0', 16:48:11 INFO - 'XPC_SERVICE_NAME': '0', 16:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:48:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0107', '--webServer', 'localhost'] with output_timeout 3600 16:48:11 INFO - mozversion INFO | application_buildid: 20151114144431 16:48:11 INFO - mozversion INFO | application_changeset: 5fb6f8b316ca76a5a4c47464900eaed2774d844f 16:48:11 INFO - mozversion INFO | application_display_name: Nightly 16:48:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:11 INFO - mozversion INFO | application_name: Firefox 16:48:11 INFO - mozversion INFO | application_remotingname: firefox 16:48:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:48:11 INFO - mozversion INFO | application_vendor: Mozilla 16:48:11 INFO - mozversion INFO | application_version: 45.0a1 16:48:11 INFO - mozversion INFO | platform_buildid: 20151114144431 16:48:11 INFO - mozversion INFO | platform_changeset: 5fb6f8b316ca76a5a4c47464900eaed2774d844f 16:48:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:48:11 INFO - mozversion INFO | platform_version: 45.0a1 16:48:11 INFO - 2015-11-14 16:48:11,335 DEBUG : using testdate: 1447548491 16:48:11 INFO - 2015-11-14 16:48:11,335 DEBUG : actual date: 1447548491 16:48:11 INFO - 2015-11-14 16:48:11,445 INFO : starting webserver on 'localhost:49267' 16:48:11 INFO - 2015-11-14 16:48:11,446 INFO : Starting test suite t-yosemite-r5-0107.e 16:48:11 INFO - 2015-11-14 16:48:11,447 INFO : Starting test dromaeo_css 16:48:11 INFO - 2015-11-14 16:48:11,447 DEBUG : operating with platform_type : mac_ 16:48:11 INFO - 2015-11-14 16:48:11,448 INFO : Initialising browser for dromaeo_css test... 16:48:11 INFO - 2015-11-14 16:48:11,469 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmpk_nnqL/profile http://localhost:49267/getInfo.html 16:48:15 INFO - 2015-11-14 16:48:15,752 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:48:15 INFO - 2015-11-14 16:48:15,752 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:48:15 INFO - 2015-11-14 16:48:15,752 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:48:15 INFO - 2015-11-14 16:48:15,752 DEBUG : BROWSER_OUTPUT: __metrics 16:48:16 INFO - 2015-11-14 16:48:16,417 INFO : Browser initialized. 16:48:16 INFO - 2015-11-14 16:48:16,418 INFO : Running cycle 1/1 for dromaeo_css test... 16:48:16 INFO - 2015-11-14 16:48:16,418 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmpk_nnqL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:48:28 INFO - 2015-11-14 16:48:28,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 240463872 16:48:28 INFO - 2015-11-14 16:48:28,579 DEBUG : BROWSER_OUTPUT: 16:49:18 INFO - 2015-11-14 16:49:18,442 DEBUG : BROWSER_OUTPUT: 1447548558440 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] 16:51:29 INFO - 2015-11-14 16:51:29,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 16:51:30 INFO - 2015-11-14 16:51:30,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 265588736 16:51:30 INFO - 2015-11-14 16:51:30,240 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-14 16:54:32,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 16:54:32 INFO - 2015-11-14 16:54:32,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 271253504 16:54:32 INFO - 2015-11-14 16:54:32,855 DEBUG : BROWSER_OUTPUT: 16:57:34 INFO - 2015-11-14 16:57:34,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 16:57:35 INFO - 2015-11-14 16:57:35,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 273387520 16:57:35 INFO - 2015-11-14 16:57:35,139 DEBUG : BROWSER_OUTPUT: 17:00:36 INFO - 2015-11-14 17:00:36,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 17:00:37 INFO - 2015-11-14 17:00:37,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 278609920 17:00:37 INFO - 2015-11-14 17:00:37,479 DEBUG : BROWSER_OUTPUT: 17:03:40 INFO - 2015-11-14 17:03:40,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 17:03:40 INFO - 2015-11-14 17:03:40,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 283541504 17:03:40 INFO - 2015-11-14 17:03:40,846 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 17:06:43 INFO - 2015-11-14 17:06:43,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 288681984 17:06:43 INFO - 2015-11-14 17:06:43,526 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,526 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:06:43 INFO - 2015-11-14 17:06:43,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:06:43 INFO - 2015-11-14 17:06:43,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:06:43 INFO - 2015-11-14 17:06:43,527 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:06:43 INFO - 2015-11-14 17:06:43,527 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2804.565292379681;2889.5954566360724;2889.869955851988;2929.443405752907;2956.8225906445614;4791.7604119794005;4793.137235297645;4820.060088282787;4918.950810491894;4940.678855874366;4765.21373973294;4776.90446191076;4801.207800712887;4841.370621819158;4971.37857767779;4473.172463094322;4538.432695913011;4612.884677883063;4622.329762184481;4642.466116396607;749.6621281465468;4340.262155433584;4523;4542.863714088583;4628.537146285362;4468.2850743881145;4524.728516289;4529.184746745585;4539.886502837439;4590.150822097889;4589.632829373642;4607.10161518504;4609.446866376023;4631.027484228282;4674.018456124218;4356.063446359017;4463.33050042493;4467.508574056851;4595.9080818383445;4629.953700462986;4560.771961401917;4681.953180468186;4707.976460117712;4777.402824646919;4808.495108013643;5041.218611115246;5078.289039534468;5081.085404627165;5124.052050370693;5136.974315128437;5100.846974590768;5107.055194788976;5147.48525147486;5173.405058418292;5184.274201611777;4887.169181239234;4891.413030436371;4904;4905.2642103684375;4967.130752118364;5246.7638956247065;5277.261183434322;5285.524302812765;5335.039692855324;5359.08895487768;4904.754762261944;4988.975055124701;5003.549680528697;5052.166392545262;5054.9241761373605;5197;5204.34945631796;5210.47895210476;5243.23973023917;5303.681779093266;5003.524665156804;5084.51697088776;5103.18349064148;5178.0679477694375;5178.741062946838;5015.297858299841;5102.897942041139;5110.437851836295;5126.307948426989;5178.223266510054;3983.143624120828;4015.0765323975065;4020.7386519876113;4027.496562929634;4044.029432936074;3564.803935783557;3633.218857945554;3697.0942119180972;3702.22253326799;3741.9251614967548;4791.185498465269;4800.135975524439;4804.327394164819;4855.32025516428;4869.732164730903;5205.9219111713355;5211.270422140903;5222.399424066281;5246.449122842123;5249.580033597303;4635.95364046362;4714.175019371596;4753.120672675566;4822.373091498082;4890.975545122252;4512.345709872116;4522.479914809774;4557.45310562728;4583.633309335311;4607.95392046082;5333.546648534841;5380.273663055437;5395.433479484676;5398.811041613525;5414.3502779665905;5073.720945347894;5078.669886457368;5094.032133894548;5168.431472537943;5263.710495922761;5228.294180285613;5243.003829272426;5266.262723218676;5295.602829787705;5321.2816269804625;5055.696658200372;5108.821191258288;5111.923321150111;5116.948830511647;5123.077845987758;5091.312672789126;5094.898102037864;5153.510416510426;5157.535821776059;5180.404253510744;5008.924866127084;5075.365579302587;5138.177891537336;5138.640295179451;5143.125668636416;5006.274090256819;5080.11098057831;5136.948630513647;5140.794368225229;5174;4724.385829842098;4829.251466022632;4903.190973489477;4991.051700176955;5017.623678224075;4902.485239049848;4981.3026176334615;5065.544101030925;5089.1094058538865;5112.872178195426;4957.950420495749;4965.627577931597;4979.526944940225;5005;5052.520010598987 17:06:43 INFO - 2015-11-14 17:06:43,528 DEBUG : BROWSER_OUTPUT: |1;ext.html;492.97781599828005;501.3307234841486;505.43138968660236;514.899594579057;523.2021167719225;33030.339393212154;33694.32611347771;33724.32551348975;33759.66240337596;33760.4935925961;37099.62900370995;37712.62287377125;37744.81127594365;37930.8103459483;38086.23827523448;8260.463069900452;8304.418690691655;8403.243708066273;8421.536815475147;8424.326053915702;8141.674333026672;8273.172682731709;8274.710385136521;8286.378521610874;8299.875501867476;8271.090180080186;8355.456895301817;8368.37237207212;8370.58147092646;8382.916170838305;8236.958815205915;8344;8349.29031032363;8349.707760228424;8361.916380836235;8076.434649574532;8235.917640823574;8249.752507424726;8257.256846883809;8257.8348433031;35423.64576354255;36292.637073629456;36327.09182270438;36351.4547281791;36486.45270320947;2567.435164263859;2606.504764094816;2640.0891692366104;2651.615515750225;2971.939408989322;24329.878350608134;24390.756092439027;24894.875525622436;25415;25775.613365799527;2170.2295685031745;2182.2034957240653;2212.668099785029;2214.0368939511204;2214.169686367612;236805;241093;241607.99999999825;243891;244428;44712.55287447149;51228;51512.48487515152;51595.484045159064;52113.47886521162;42118.57881421208;60299;61019;61335.07997380043;61504;12835.679108022186;12946.546870859474;13047.956163506897;13131.34343282832;13140.408681609159;8652.04827468978;8663.610137543825;8674.653013879373;8674.86987695185;8683.392162548562;17002.489925302012;17209.397671081704;17229.39697110595;17283.481495555152;17364.91317543404;7199.172095209014;7258.0927384076995;7347.926520734724;7389.593572353572;7402.778541540585;843.42225575481;881.272949816404;900.5497251374313;980.4509474694194;1029.3463650581934;24489;25279.185787268663;25361.49277014486;25396;25837.483250334888;939.0187254319253;1007.7531004903699;1070.91302328137;1121.9102471802237;1124.3703526025288;13170.275634839983;13259.403326850315;13411.932940335237;13600.251986140856;13921;282088;285487;285583;286384;288223;49087.50912490829;49279.260811087865;49294.50705492971;49618;49669;1235.2279825109306;1244.595506460404;1248.2572869142846;1248.887600115994;1253.1854294708512;25424.491510169322;26067.217983460527;26191.214263572125;26240.60639090377;26638;42287.788561057;42987.78506107449;43039.784801075795;43124.56875431331;43394.78302608467;254630;256049;257388;257604;257722;26321.341966450225;26581.335466612716;26804.463910722065;26843.19470415891;27111;36710.44934325934;37417.251654967295;37609.81195094007;37923.431148533346;38210.426843597925;30892.845535773078;31421.52867707032;31849.36301274008;33642.831785840914;34018.489722653685;30993.69006309998;30994.535081974238;31015.534766978966;31032.68967310298;31063.68936310608;31926.6807331933;32439.351212976082;32609.18477038093;32649.836750816095;32902.50646240356;26134;26641.467170656866;27163.72836271612;28006.57990130109;28316;20453.897730511253;20568.38401208776;21393.144274228856;21426.892865535574;21504.354869353945 17:06:43 INFO - 2015-11-14 17:06:43,532 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.8199157518127;293.53035143769955;297.01835433890983;297.6874282003896;304.38210432821376;10377.792444151113;10776.892231077707;15246.161461119635;15438.305276262567;15754.527364179079;10269.075783179513;10279.897201027987;10510.264281500298;10539.104176145018;10654.733631659212;3828.4257361395876;3937.645611894929;3941.1920556286036;3956.5845586213463;3963.524377074755;2982.5526171074403;3922.235164142993;3956.960430395688;3960.9405858911996;3995.5005624296964;3958.6635136013474;3962.2669806085823;4006.9599304007024;4111.48606424197;4162.687798415131;4130.834766609332;4157.08544120293;4179.874603761892;4180.393842892794;4187.120704652027;3385.153711572107;3488.9707536276605;3508.824558772051;3510.052285882823;3548.556430446194;9726.36778609388;9920.503974801304;11156.497957591928;11542.07663386927;11644.359560224184;1541.537538738374;1542.5680809373393;1614.9757753633705;1634.7302695055303;1680.7478878168251;8342.582870856433;8444;8479.788005299855;8530.530820804854;8565.486070835708;1355.6068740065368;1391.193107997359;1418.6453386653336;1429.4710956945892;1440.272662305529;46214;48053.03893922102;48619.27071093937;48741.75629121867;48974.51025489735;5775.191473193672;5808.215890854765;5835.4748072673665;5846.8538286542325;5849.619774714715;6548.967255163694;6557.049227861933;6622.768203112868;6631.204255489372;6633.668316584151;4670.626349892001;4681.274402467623;4706.647001474903;4752.1683705351425;4756.5956893664425;4905.901881962341;4919.803207871717;4933.186024306021;4950.554450099508;4985.077760614298;2590.2617753940413;2591.1449221756775;2599.8440093594445;2602.9479410411686;2615.992842755553;913.7578541686458;916.4409710076848;918.4305730447165;926.2821313482106;991.9931269761198;350.2155172413775;371.7750760789737;380.29455360306787;381.57073292545886;396.13444623497173;9860.30977831545;10353.171746260281;10480.161587073017;10511.106555942677;10688.839667404995;402.30200601955585;402.8086658837087;412.79154027216066;419.93910882922415;420.9305464598368;5514.09017512114;5696.174054762037;5708.086706127;5727.3699893011735;5744.569157313218;491069;492241;504086;504954;505095;63729;64848.67575662091;64945.350546494876;65750.67124664442;65913.34086659168;420.2834167743989;421.5510481337366;425.47241420638807;426.0286546673589;426.1562107028102;9587.568559414703;9631.855522167032;9657.9034209657;9706.272029597667;9714.174295184988;28822.567661484674;29848.104556863327;30481.39037219199;30517;30563.847180763954;41309.38035929403;41660.58339416688;42079.57920420756;42437.57562424336;42440.575594244896;5426.945730542644;5458.181272809111;5510.559155267489;5513.393526711979;5516.558675306046;10205.897941020792;10283.485825708834;10425.165986721197;10515.474226288808;10515.789684206426;7616.961915190389;8216.137305582828;8882.022977472343;8976.371653984419;9174.449533028039;8306.792330191794;8508.404411691123;8548.230659240699;8621.13788621158;8748.037715851378;8703.97461010121;8989.595468204077;9068.546572671472;9161.77095572616;9258;5393.460653934575;5405.108157154025;5421.349438067299;5453.345598528202;5473.698946557977;8866.069062748318;8960.596773145355;9007.144321289466;9046;9120.49837258957 17:06:43 INFO - 2015-11-14 17:06:43,533 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1280.5966120671985;1414.4483651375958;1478.209158100416;1643.7863077799884;1643.8931469454492;6275.843103922392;6406.295307516181;6797.048413222153;6871.55334903231;6958.791236262914;6697.2967838377;6915.827104322394;7019.333163349474;7020.578765274087;7021.578705277687;1980.1089509720612;2002.429307647321;2010.4169790760734;2020.7878172791793;2023.9880059970014;1977.9011049447543;2015.3147929703898;2036.531597732515;2104.8947552622385;2110.5040315525916;1948.6492431362349;1983.1373352591597;1997.0613811508567;2001.3495613925459;2010.497375656086;2035.9389218323474;2044.7648520420119;2053.117159621362;2054;2065.834733221339;1961.4900125967208;1990.1243452880685;2013.456366780961;2015.54650203703;2038.7553493580717;6664.966675166642;6665.300143484913;6688.531802773808;6701.128853249095;6705.798826035227;4311.094670119279;4330.935035974463;4378.277584198603;4381.036172042146;4425.092855964552;2384.165542060265;2473.863937483438;2664.0542607374296;2734.8359098454157;2777.6389069421048;788.2669117720518;822.3298012120163;826.8925039744795;833.6582001379466;833.8999320081568;9539.284553658434;9546.284028697806;9561.187299079587;9611.519424028771;9629.229661627123;3922.7646341219047;3926.411038344271;3940.4483372327895;3966.9884179534033;3998.520177578709;8162.959185204036;8185.549794761227;8192.795180120545;8276.462029968034;8306.377021723274;4395.648348132142;4397.054633253866;4412.977935110368;4426.269665505156;4434.17967675981;3992.5208974923194;4019.8995025124605;4022.7586344819406;4031.213913286881;4062.106336605942;3309.6028476582965;3382.374260761767;3391.609964854024;3415.4023045966856;3442.4836274558515;1104.817705078653;1119.8992090711874;1121.876593574706;1132.2300835431986;1136.9886301137049;938.1181689212119;962.9614815407306;966.989495976706;1018.6842078955548;1210.4189988805422;6636.2368327642935;6676.365745254193;6687.732490700415;6690.330966903271;6764.76323328691;424.94688163979504;425.090306743569;429.45673722740133;430.70927124191047;431.7193824014416;5171.663841850343;5216.58267338612;5228.2680424740565;5260.395054568774;5307.495787900143;8018.198180181935;8316.833663326699;8344.290735287446;8371.874421883676;8485.830283394422;8245.752627421187;8276.751697449086;8299.087100418948;8331.875021874677;8393.412461127662;6491.734111848239;6564.8030559082345;6577.539572229994;6583.736650533925;6698.832529186712;6307.90538141919;6314.242290925118;6332.968335158294;6352.110704501281;6408;7152.320529549893;7175.820604484929;7325.157606875277;7356.558606483628;7387.630618468947;7398.186199518156;7591.696332146652;7677.923220767944;7716.807079823049;7718.614069296625;6141.109539116893;6165.6608886509875;6165.815025549241;6167.259928808572;6230.813075607739;6630.469562434897;6698.430633396216;6725.260221375743;6743.15710536183;6796.864062718619;6271.498280137487;6297.55917085818;6311.589746666452;6348.809535713936;6385;6047.546434017554;6121.112438696453;6143.539234557336;6199.3490683477585;6239.688015599293;6233.314335423191;6267.341929097562;6301.243850737941;6323.683815809283;6357.618542887441;5711.257536520392;5769.653820770767;5770.596058275881;5844.590878638624;5856.531477481706;5364.275822763877;5399;5509.090999984957;5806.187133801355;5928.67392293428 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: |4;prototype.html;277.53789939750317;282.94624021435925;287.79997901458484;288.4591391141611;293.54500524187506;5689.971550142249;5711.885762284752;5742.942570574293;5773.5092517136045;5795.304563452381;5617.606767526275;5718.59969802114;5796.101604251337;5796.333421656511;5808.099744539592;4445.799634098791;4459.710118842281;4460.7323560586465;4483.170613436525;4493.595576398124;4337.54455782143;4451.732896026248;4455.84404545841;4472.329150627399;4480.238359478896;4315.180115778008;4380.08018316154;4388.67084968627;4410.71330363527;4429.357743127244;4368.322909948963;4382.561743825624;4413.6910416270875;4429.446319210083;4434.512203657595;3770.8491660333552;3776.3013842438963;3819.8281077351585;3826.6747326477284;3833.7891415972113;5354.170103633943;5377.8117765878005;5509.917351239735;5555.916661250085;5579.525740312079;4834.516548345173;4843.07981483517;4877.707337559757;4887.853364399074;4898.624167278903;5953.970230148865;6025.668588227646;6026.9095963560585;6031.6079454835735;6055.212822333113;3930.1353702185475;3985.80070996449;4031.455753473273;4033.072393349517;4034.677225821927;6113.908291375633;6277.937220627827;6281;6309.905351419732;6330.240371155444;4160.251154792106;4162.687798415131;4192.601702838226;4198.223328684203;4203.390508376329;4225.070484493406;4234.745915245096;4271.423357846713;4274.850380236677;4282.100758840616;4896.045271172158;4904.2643603459765;4916.901661966741;4935.975320123448;4947.604191664658;5793;5979.880402391927;6043.153958445733;6044.546659000593;6062.393760623991;1485.7548504496854;1489.240487351437;1489.9793641355707;1506.9623259418602;1510.3128076725063;959.5298303831212;983.9065288797696;990.4008075114596;991.5570390732463;996.5117092624706;5614.9719251403485;5629.24005259293;5636;5638.323401191883;5703.800366987219;6204.844878877974;6205.2553693557065;6234.844128896814;6245.718942647592;6274.1843560336865;5601.887962240814;5611.8597035073635;5692.31692196939;5693.629914055573;5696.914546281809;3271.362084393568;3373.730101591867;3405.897823065312;3417.0432278961434;3455.2053027803745;6500.187476565429;6503.4146926775875;6512.185976752906;6524.739010439529;6529.5102867284195;6220.191375121205;6291.182146320949;6333.556651034383;6344.555881088372;6515.413612774873;6386.10594516768;6440.967795160994;6509.479241660656;6511.674416279167;6514.315996820361;6259.499240060875;6323.588966717149;6330.240371155307;6345.90481142774;6363.172787537591;5972.850678732892;6168.414000669929;6210.720517576629;6234.2830574484515;6237.313895471585;6415.1981002374705;6441.67791610427;6501.1548498694865;6512.902306465501;6524.314946930694;3947.6052394760295;3956.663683586927;3978.3634618460906;4013.0569316210085;4026.2148880969103;6048.939510604838;6249.281332646804;6253.843653908689;6295.811125666238;6338.049292605961;6075.665838378932;6077.301110372364;6111.449969502766;6142.078688196806;6155.076738489262;6055.333913269449;6066.575339726177;6105.938940610715;6126.969365153146;6142.201513803356;5641.633293835887;5855.707214639166;5945.583809133319;5951.047832346804;5960.463558279602;6053.213082299273;6061.727222275096;6115.113308570321;6116.082587611894;6137.570370074052;5937.198478205387;5939.10913362999;6001.849953751192;6019.638821670714;6029.60807547508 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: |5;yui.html;552.1221258199463;620.6896551724138;655.5607742812315;667.6066302306232;676.7462201674372;11493.655190344281;11961.521539138446;12254.693632659188;12721.236725796458;12744.872551274484;11021.393823339713;11152.553897844076;11203.327800331987;11221.60724374647;11273.661790146309;755.5768769489076;762.1692355332673;780.7813812132583;781.2460975158971;791.2720297326445;792.4848848248656;801.2388231180373;802.0215337288528;804.4127786715701;813.1989989860012;829.5022986208287;831.4927893984665;832.8375966686499;836.9539675317855;842.7050532313672;826.4297634632085;826.7726375246795;827.9503229806231;830.2527725047476;833.7123692326138;614.735663664624;614.978475753351;616.9912193563556;618.5917294585597;620.2804746494045;11825.704357391049;11919.404029798563;12398.938005310007;12411.379431028503;12424.627261182179;10160.187185025181;10314.12329951955;10436.843447348296;10531.104856087166;10707.678769636923;8188.754337369829;8214.219649133323;8334.541600211985;8443.620037098346;8802.647894084294;2874.5831854381;2908.679380143543;2949.7492713119195;2960.4375168717875;3019.124453908364;42399.36400953988;42926.57073429288;43251.78374108141;43513.34729979053;43639.563604364186;7727.690892364242;7905.802354941173;7932.643031063616;7995.320397766139;8254.092049874509;16543.172841357886;16638;16679.91660041692;16708.331666733437;16711.080890551137;5475.370332411744;5625.268715067097;6437.324080971524;6459.644719540376;6608.041833934052;3417.1627951152127;3435.2270739084006;3526.1360966563357;3594.7843129412317;3615.9276814463565;2711.498372801038;2747.5191841427672;2775.4865349910333;2777.652793400825;2781.3880946191807;396.8096504107005;404.34219699233495;407.8001779128206;416.7020580285111;420.459709273582;458.8325261279609;506.06630766236236;510.5328624308716;526.7682219823265;562.3954249182063;6822.556533825285;6987.336203060701;7123.358897699232;7232.74685386009;7245.748566246626;506.60484821839026;514.369896876331;541.656048409263;544.9400565937743;554.967759966462;3199;3442.4836274558515;3655.817209139532;3701.722370822199;3852.6917846572205;52388.214176787376;53253.46746532485;53582.7320863401;53789.73105134449;53818;44602.33096503555;45480.317795233095;45714.77142614266;45777;45873;44719.32921006188;44936.3259551107;45584.54415455803;45862.77068614702;46403;7251.56490610565;7252.383547398319;7294.781156565312;7625.275598818103;7675.654595543102;27744.861275693493;27891.721082788914;28333.291667708472;28503;28608.284792880346;36454.635453645125;36722.08194795045;40514.18971620492;41388.586114138474;41634.79182604067;9067.319951003568;9480;9733.37839987291;9827.950860245654;10022;9756.170725488413;9928.602855885973;9970.50147492637;10059.094681478702;10183.84724229152;9379.812403752023;9666.178374837937;9723.173530250007;9732.41605503672;9747.415155090717;9438.150566449052;9651.951740241253;9735.853962190431;9786.510674466106;9799.412035277906;8678;8890.955545222232;9377;9450.291228158054;9616.230701544;8104.635291412019;8203.179682031989;8518.318534517348;8600.311975042106;8623.525706086226;8183.83632327362;8193.83612327762;8236.546989915612;8248.46384984974;8341.45780524264 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 17:06:43 INFO - 2015-11-14 17:06:43,537 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: __startTimestamp1447549603523__endTimestamp 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,538 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4799.46 Median:4981.30 stddev:592.88 (11.9%) stddev-sans-first:573.67 17:06:43 INFO - 2015-11-14 17:06:43,540 DEBUG : BROWSER_OUTPUT: Values: 2804.6 2889.6 2889.9 2929.4 2956.8 4791.8 4793.1 4820.1 4919.0 4940.7 4765.2 4776.9 4801.2 4841.4 4971.4 4473.2 4538.4 4612.9 4622.3 4642.5 749.7 4340.3 4523.0 4542.9 4628.5 4468.3 4524.7 4529.2 4539.9 4590.2 4589.6 4607.1 4609.4 4631.0 4674.0 4356.1 4463.3 4467.5 4595.9 4630.0 4560.8 4682.0 4708.0 4777.4 4808.5 5041.2 5078.3 5081.1 5124.1 5137.0 5100.8 5107.1 5147.5 5173.4 5184.3 4887.2 4891.4 4904.0 4905.3 4967.1 5246.8 5277.3 5285.5 5335.0 5359.1 4904.8 4989.0 5003.5 5052.2 5054.9 5197.0 5204.3 5210.5 5243.2 5303.7 5003.5 5084.5 5103.2 5178.1 5178.7 5015.3 5102.9 5110.4 5126.3 5178.2 3983.1 4015.1 4020.7 4027.5 4044.0 3564.8 3633.2 3697.1 3702.2 3741.9 4791.2 4800.1 4804.3 4855.3 4869.7 5205.9 5211.3 5222.4 5246.4 5249.6 4636.0 4714.2 4753.1 4822.4 4891.0 4512.3 4522.5 4557.5 4583.6 4608.0 5333.5 5380.3 5395.4 5398.8 5414.4 5073.7 5078.7 5094.0 5168.4 5263.7 5228.3 5243.0 5266.3 5295.6 5321.3 5055.7 5108.8 5111.9 5116.9 5123.1 5091.3 5094.9 5153.5 5157.5 5180.4 5008.9 5075.4 5138.2 5138.6 5143.1 5006.3 5080.1 5136.9 5140.8 5174.0 4724.4 4829.3 4903.2 4991.1 5017.6 4902.5 4981.3 5065.5 5089.1 5112.9 4958.0 4965.6 4979.5 5005.0 5052.5 17:06:43 INFO - 2015-11-14 17:06:43,540 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,541 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41272.83 Median:32629.51 stddev:68491.81 (209.9%) stddev-sans-first:68615.51 17:06:43 INFO - 2015-11-14 17:06:43,542 DEBUG : BROWSER_OUTPUT: Values: 493.0 501.3 505.4 514.9 523.2 33030.3 33694.3 33724.3 33759.7 33760.5 37099.6 37712.6 37744.8 37930.8 38086.2 8260.5 8304.4 8403.2 8421.5 8424.3 8141.7 8273.2 8274.7 8286.4 8299.9 8271.1 8355.5 8368.4 8370.6 8382.9 8237.0 8344.0 8349.3 8349.7 8361.9 8076.4 8235.9 8249.8 8257.3 8257.8 35423.6 36292.6 36327.1 36351.5 36486.5 2567.4 2606.5 2640.1 2651.6 2971.9 24329.9 24390.8 24894.9 25415.0 25775.6 2170.2 2182.2 2212.7 2214.0 2214.2 236805.0 241093.0 241608.0 243891.0 244428.0 44712.6 51228.0 51512.5 51595.5 52113.5 42118.6 60299.0 61019.0 61335.1 61504.0 12835.7 12946.5 13048.0 13131.3 13140.4 8652.0 8663.6 8674.7 8674.9 8683.4 17002.5 17209.4 17229.4 17283.5 17364.9 7199.2 7258.1 7347.9 7389.6 7402.8 843.4 881.3 900.5 980.5 1029.3 24489.0 25279.2 25361.5 25396.0 25837.5 939.0 1007.8 1070.9 1121.9 1124.4 13170.3 13259.4 13411.9 13600.3 13921.0 282088.0 285487.0 285583.0 286384.0 288223.0 49087.5 49279.3 49294.5 49618.0 49669.0 1235.2 1244.6 1248.3 1248.9 1253.2 25424.5 26067.2 26191.2 26240.6 26638.0 42287.8 42987.8 43039.8 43124.6 43394.8 254630.0 256049.0 257388.0 257604.0 257722.0 26321.3 26581.3 26804.5 26843.2 27111.0 36710.4 37417.3 37609.8 37923.4 38210.4 30892.8 31421.5 31849.4 33642.8 34018.5 30993.7 30994.5 31015.5 31032.7 31063.7 31926.7 32439.4 32609.2 32649.8 32902.5 26134.0 26641.5 27163.7 28006.6 28316.0 20453.9 20568.4 21393.1 21426.9 21504.4 17:06:43 INFO - 2015-11-14 17:06:43,542 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,542 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23877.95 Median:426.09 stddev:81813.90 (19201.0%) stddev-sans-first:82024.24 17:06:43 INFO - 2015-11-14 17:06:43,543 DEBUG : BROWSER_OUTPUT: Values: 292.8 293.5 297.0 297.7 304.4 10377.8 10776.9 15246.2 15438.3 15754.5 10269.1 10279.9 10510.3 10539.1 10654.7 3828.4 3937.6 3941.2 3956.6 3963.5 2982.6 3922.2 3957.0 3960.9 3995.5 3958.7 3962.3 4007.0 4111.5 4162.7 4130.8 4157.1 4179.9 4180.4 4187.1 3385.2 3489.0 3508.8 3510.1 3548.6 9726.4 9920.5 11156.5 11542.1 11644.4 1541.5 1542.6 1615.0 1634.7 1680.7 8342.6 8444.0 8479.8 8530.5 8565.5 1355.6 1391.2 1418.6 1429.5 1440.3 46214.0 48053.0 48619.3 48741.8 48974.5 5775.2 5808.2 5835.5 5846.9 5849.6 6549.0 6557.0 6622.8 6631.2 6633.7 4670.6 4681.3 4706.6 4752.2 4756.6 4905.9 4919.8 4933.2 4950.6 4985.1 2590.3 2591.1 2599.8 2602.9 2616.0 913.8 916.4 918.4 926.3 992.0 350.2 371.8 380.3 381.6 396.1 9860.3 10353.2 10480.2 10511.1 10688.8 402.3 402.8 412.8 419.9 420.9 5514.1 5696.2 5708.1 5727.4 5744.6 491069.0 492241.0 504086.0 504954.0 505095.0 63729.0 64848.7 64945.4 65750.7 65913.3 420.3 421.6 425.5 426.0 426.2 9587.6 9631.9 9657.9 9706.3 9714.2 28822.6 29848.1 30481.4 30517.0 30563.8 41309.4 41660.6 42079.6 42437.6 42440.6 5426.9 5458.2 5510.6 5513.4 5516.6 10205.9 10283.5 10425.2 10515.5 10515.8 7617.0 8216.1 8882.0 8976.4 9174.4 8306.8 8508.4 8548.2 8621.1 8748.0 8704.0 8989.6 9068.5 9161.8 9258.0 5393.5 5405.1 5421.3 5453.3 5473.7 8866.1 8960.6 9007.1 9046.0 9120.5 17:06:43 INFO - 2015-11-14 17:06:43,543 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,544 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4867.90 Median:6154.60 stddev:2527.40 (41.1%) stddev-sans-first:2520.10 17:06:43 INFO - 2015-11-14 17:06:43,545 DEBUG : BROWSER_OUTPUT: Values: 1280.6 1414.4 1478.2 1643.8 1643.9 6275.8 6406.3 6797.0 6871.6 6958.8 6697.3 6915.8 7019.3 7020.6 7021.6 1980.1 2002.4 2010.4 2020.8 2024.0 1977.9 2015.3 2036.5 2104.9 2110.5 1948.6 1983.1 1997.1 2001.3 2010.5 2035.9 2044.8 2053.1 2054.0 2065.8 1961.5 1990.1 2013.5 2015.5 2038.8 6665.0 6665.3 6688.5 6701.1 6705.8 4311.1 4330.9 4378.3 4381.0 4425.1 2384.2 2473.9 2664.1 2734.8 2777.6 788.3 822.3 826.9 833.7 833.9 9539.3 9546.3 9561.2 9611.5 9629.2 3922.8 3926.4 3940.4 3967.0 3998.5 8163.0 8185.5 8192.8 8276.5 8306.4 4395.6 4397.1 4413.0 4426.3 4434.2 3992.5 4019.9 4022.8 4031.2 4062.1 3309.6 3382.4 3391.6 3415.4 3442.5 1104.8 1119.9 1121.9 1132.2 1137.0 938.1 963.0 967.0 1018.7 1210.4 6636.2 6676.4 6687.7 6690.3 6764.8 424.9 425.1 429.5 430.7 431.7 5171.7 5216.6 5228.3 5260.4 5307.5 8018.2 8316.8 8344.3 8371.9 8485.8 8245.8 8276.8 8299.1 8331.9 8393.4 6491.7 6564.8 6577.5 6583.7 6698.8 6307.9 6314.2 6333.0 6352.1 6408.0 7152.3 7175.8 7325.2 7356.6 7387.6 7398.2 7591.7 7677.9 7716.8 7718.6 6141.1 6165.7 6165.8 6167.3 6230.8 6630.5 6698.4 6725.3 6743.2 6796.9 6271.5 6297.6 6311.6 6348.8 6385.0 6047.5 6121.1 6143.5 6199.3 6239.7 6233.3 6267.3 6301.2 6323.7 6357.6 5711.3 5769.7 5770.6 5844.6 5856.5 5364.3 5399.0 5509.1 5806.2 5928.7 17:06:43 INFO - 2015-11-14 17:06:43,545 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,546 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5037.18 Median:5758.23 stddev:1541.62 (26.8%) stddev-sans-first:1503.98 17:06:43 INFO - 2015-11-14 17:06:43,546 DEBUG : BROWSER_OUTPUT: Values: 277.5 282.9 287.8 288.5 293.5 5690.0 5711.9 5742.9 5773.5 5795.3 5617.6 5718.6 5796.1 5796.3 5808.1 4445.8 4459.7 4460.7 4483.2 4493.6 4337.5 4451.7 4455.8 4472.3 4480.2 4315.2 4380.1 4388.7 4410.7 4429.4 4368.3 4382.6 4413.7 4429.4 4434.5 3770.8 3776.3 3819.8 3826.7 3833.8 5354.2 5377.8 5509.9 5555.9 5579.5 4834.5 4843.1 4877.7 4887.9 4898.6 5954.0 6025.7 6026.9 6031.6 6055.2 3930.1 3985.8 4031.5 4033.1 4034.7 6113.9 6277.9 6281.0 6309.9 6330.2 4160.3 4162.7 4192.6 4198.2 4203.4 4225.1 4234.7 4271.4 4274.9 4282.1 4896.0 4904.3 4916.9 4936.0 4947.6 5793.0 5979.9 6043.2 6044.5 6062.4 1485.8 1489.2 1490.0 1507.0 1510.3 959.5 983.9 990.4 991.6 996.5 5615.0 5629.2 5636.0 5638.3 5703.8 6204.8 6205.3 6234.8 6245.7 6274.2 5601.9 5611.9 5692.3 5693.6 5696.9 3271.4 3373.7 3405.9 3417.0 3455.2 6500.2 6503.4 6512.2 6524.7 6529.5 6220.2 6291.2 6333.6 6344.6 6515.4 6386.1 6441.0 6509.5 6511.7 6514.3 6259.5 6323.6 6330.2 6345.9 6363.2 5972.9 6168.4 6210.7 6234.3 6237.3 6415.2 6441.7 6501.2 6512.9 6524.3 3947.6 3956.7 3978.4 4013.1 4026.2 6048.9 6249.3 6253.8 6295.8 6338.0 6075.7 6077.3 6111.4 6142.1 6155.1 6055.3 6066.6 6105.9 6127.0 6142.2 5641.6 5855.7 5945.6 5951.0 5960.5 6053.2 6061.7 6115.1 6116.1 6137.6 5937.2 5939.1 6001.8 6019.6 6029.6 17:06:43 INFO - 2015-11-14 17:06:43,546 DEBUG : BROWSER_OUTPUT: 17:06:43 INFO - 2015-11-14 17:06:43,546 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12174.03 Median:3010.16 stddev:14569.59 (484.0%) stddev-sans-first:14584.32 17:06:43 INFO - 2015-11-14 17:06:43,547 DEBUG : BROWSER_OUTPUT: Values: 552.1 620.7 655.6 667.6 676.7 11493.7 11961.5 12254.7 12721.2 12744.9 11021.4 11152.6 11203.3 11221.6 11273.7 755.6 762.2 780.8 781.2 791.3 792.5 801.2 802.0 804.4 813.2 829.5 831.5 832.8 837.0 842.7 826.4 826.8 828.0 830.3 833.7 614.7 615.0 617.0 618.6 620.3 11825.7 11919.4 12398.9 12411.4 12424.6 10160.2 10314.1 10436.8 10531.1 10707.7 8188.8 8214.2 8334.5 8443.6 8802.6 2874.6 2908.7 2949.7 2960.4 3019.1 42399.4 42926.6 43251.8 43513.3 43639.6 7727.7 7905.8 7932.6 7995.3 8254.1 16543.2 16638.0 16679.9 16708.3 16711.1 5475.4 5625.3 6437.3 6459.6 6608.0 3417.2 3435.2 3526.1 3594.8 3615.9 2711.5 2747.5 2775.5 2777.7 2781.4 396.8 404.3 407.8 416.7 420.5 458.8 506.1 510.5 526.8 562.4 6822.6 6987.3 7123.4 7232.7 7245.7 506.6 514.4 541.7 544.9 555.0 3199.0 3442.5 3655.8 3701.7 3852.7 52388.2 53253.5 53582.7 53789.7 53818.0 44602.3 45480.3 45714.8 45777.0 45873.0 44719.3 44936.3 45584.5 45862.8 46403.0 7251.6 7252.4 7294.8 7625.3 7675.7 27744.9 27891.7 28333.3 28503.0 28608.3 36454.6 36722.1 40514.2 41388.6 41634.8 9067.3 9480.0 9733.4 9828.0 10022.0 9756.2 9928.6 9970.5 10059.1 10183.8 9379.8 9666.2 9723.2 9732.4 9747.4 9438.2 9652.0 9735.9 9786.5 9799.4 8678.0 8891.0 9377.0 9450.3 9616.2 8104.6 8203.2 8518.3 8600.3 8623.5 8183.8 8193.8 8236.5 8248.5 8341.5 17:06:43 INFO - 2015-11-14 17:06:43,547 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:06:43 INFO - 2015-11-14 17:06:43,548 DEBUG : BROWSER_OUTPUT: 17:06:44 INFO - 2015-11-14 17:06:44,000 INFO : Browser exited with error code: 0 17:06:44 INFO - 2015-11-14 17:06:44,032 INFO : Completed test dromaeo_css (00:18:32) 17:06:44 INFO - 2015-11-14 17:06:44,032 INFO : Starting test kraken 17:06:44 INFO - 2015-11-14 17:06:44,032 DEBUG : operating with platform_type : mac_ 17:06:44 INFO - 2015-11-14 17:06:44,032 INFO : Initialising browser for kraken test... 17:06:44 INFO - 2015-11-14 17:06:44,047 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmphyPwlJ/profile http://localhost:49267/getInfo.html 17:06:47 INFO - 2015-11-14 17:06:47,187 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:06:47 INFO - 2015-11-14 17:06:47,188 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:06:47 INFO - 2015-11-14 17:06:47,188 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:06:47 INFO - 2015-11-14 17:06:47,188 DEBUG : BROWSER_OUTPUT: __metrics 17:06:47 INFO - 2015-11-14 17:06:47,906 INFO : Browser initialized. 17:06:47 INFO - 2015-11-14 17:06:47,907 INFO : Running cycle 1/1 for kraken test... 17:06:47 INFO - 2015-11-14 17:06:47,907 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmphyPwlJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:00 INFO - 2015-11-14 17:07:00,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 240902144 17:07:00 INFO - 2015-11-14 17:07:00,053 DEBUG : BROWSER_OUTPUT: 17:07:02 INFO - 2015-11-14 17:07:02,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:03 INFO - 2015-11-14 17:07:03,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 258883584 17:07:03 INFO - 2015-11-14 17:07:03,441 DEBUG : BROWSER_OUTPUT: 17:07:06 INFO - 2015-11-14 17:07:06,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 17:07:07 INFO - 2015-11-14 17:07:07,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 267550720 17:07:07 INFO - 2015-11-14 17:07:07,003 DEBUG : BROWSER_OUTPUT: 17:07:10 INFO - 2015-11-14 17:07:10,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 17:07:10 INFO - 2015-11-14 17:07:10,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 268296192 17:07:10 INFO - 2015-11-14 17:07:10,752 DEBUG : BROWSER_OUTPUT: 17:07:12 INFO - 2015-11-14 17:07:12,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 17:07:13 INFO - 2015-11-14 17:07:13,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 268361728 17:07:13 INFO - 2015-11-14 17:07:13,518 DEBUG : BROWSER_OUTPUT: 17:07:15 INFO - 2015-11-14 17:07:15,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:16 INFO - 2015-11-14 17:07:16,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 268607488 17:07:16 INFO - 2015-11-14 17:07:16,423 DEBUG : BROWSER_OUTPUT: 17:07:19 INFO - 2015-11-14 17:07:19,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:20 INFO - 2015-11-14 17:07:20,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 268840960 17:07:20 INFO - 2015-11-14 17:07:20,400 DEBUG : BROWSER_OUTPUT: 17:07:23 INFO - 2015-11-14 17:07:23,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:24 INFO - 2015-11-14 17:07:24,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 265342976 17:07:24 INFO - 2015-11-14 17:07:24,481 DEBUG : BROWSER_OUTPUT: 17:07:27 INFO - 2015-11-14 17:07:27,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 17:07:28 INFO - 2015-11-14 17:07:28,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 266072064 17:07:28 INFO - 2015-11-14 17:07:28,238 DEBUG : BROWSER_OUTPUT: 17:07:29 INFO - 2015-11-14 17:07:29,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:30 INFO - 2015-11-14 17:07:30,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 267517952 17:07:30 INFO - 2015-11-14 17:07:30,523 DEBUG : BROWSER_OUTPUT: 17:07:32 INFO - 2015-11-14 17:07:32,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:33 INFO - 2015-11-14 17:07:33,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 267665408 17:07:33 INFO - 2015-11-14 17:07:33,149 DEBUG : BROWSER_OUTPUT: 17:07:35 INFO - 2015-11-14 17:07:35,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:36 INFO - 2015-11-14 17:07:36,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 267714560 17:07:36 INFO - 2015-11-14 17:07:36,063 DEBUG : BROWSER_OUTPUT: 17:07:38 INFO - 2015-11-14 17:07:38,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:39 INFO - 2015-11-14 17:07:39,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 268165120 17:07:39 INFO - 2015-11-14 17:07:39,538 DEBUG : BROWSER_OUTPUT: 17:07:42 INFO - 2015-11-14 17:07:42,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:43 INFO - 2015-11-14 17:07:43,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 267096064 17:07:43 INFO - 2015-11-14 17:07:43,013 DEBUG : BROWSER_OUTPUT: 17:07:44 INFO - 2015-11-14 17:07:44,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 17:07:45 INFO - 2015-11-14 17:07:45,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 268333056 17:07:45 INFO - 2015-11-14 17:07:45,126 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,127 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;115;126;126;128;140;125;128;129;125 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;153;179;187;151;172;171;176;189;150 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: |2;audio-dft;188;191;194;197;193;193;193;192;195;195 17:07:45 INFO - 2015-11-14 17:07:45,128 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;84;95;131;79;78;82;90;135;78 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;104;149;101;105;105;144;104;104;147 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;135;143;135;143;135;138;150;143;142 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;150;149;150;150;150;149;149;150 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;118;117;115;121;117;119;111;122;121 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;72;75;73;74;73;75;74;74;73 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;79;82;81;82;82;82;83;81;84;83 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;103;103;105;106;102;102;103;114;103 17:07:45 INFO - 2015-11-14 17:07:45,129 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;148;158;168;152;145;163;170;144;147 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;180;183;182;181;182;169;172;182;178;171 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;85;84;84;85;83;83;84;81;85 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,737 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:07:45 INFO - 2015-11-14 17:07:45,130 DEBUG : BROWSER_OUTPUT: __startTimestamp1447549665126__endTimestamp 17:07:45 INFO - 2015-11-14 17:07:45,131 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:07:45 INFO - 2015-11-14 17:07:45,132 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:126.90 Median:127.50 stddev:6.05 (4.7%) stddev-sans-first:6.41 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: Values: 127.0 115.0 126.0 126.0 128.0 140.0 125.0 128.0 129.0 125.0 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:170.50 Median:176.50 stddev:14.41 (8.2%) stddev-sans-first:15.09 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: Values: 177.0 153.0 179.0 187.0 151.0 172.0 171.0 176.0 189.0 150.0 17:07:45 INFO - 2015-11-14 17:07:45,133 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,134 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.10 Median:193.50 stddev:2.47 (1.3%) stddev-sans-first:1.80 17:07:45 INFO - 2015-11-14 17:07:45,134 DEBUG : BROWSER_OUTPUT: Values: 188.0 191.0 194.0 197.0 193.0 193.0 193.0 192.0 195.0 195.0 17:07:45 INFO - 2015-11-14 17:07:45,134 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,134 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.30 Median:81.50 stddev:21.63 (26.5%) stddev-sans-first:22.48 17:07:45 INFO - 2015-11-14 17:07:45,134 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 95.0 131.0 79.0 78.0 82.0 90.0 135.0 78.0 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.20 Median:124.50 stddev:21.14 (17.0%) stddev-sans-first:21.49 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: Values: 99.0 104.0 149.0 101.0 105.0 105.0 144.0 104.0 104.0 147.0 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:140.60 Median:142.50 stddev:4.84 (3.4%) stddev-sans-first:5.10 17:07:45 INFO - 2015-11-14 17:07:45,135 DEBUG : BROWSER_OUTPUT: Values: 142.0 135.0 143.0 135.0 143.0 135.0 138.0 150.0 143.0 142.0 17:07:45 INFO - 2015-11-14 17:07:45,136 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,136 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 17:07:45 INFO - 2015-11-14 17:07:45,136 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 150.0 149.0 150.0 150.0 150.0 149.0 149.0 150.0 17:07:45 INFO - 2015-11-14 17:07:45,136 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,136 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.30 Median:120.00 stddev:3.50 (2.9%) stddev-sans-first:3.44 17:07:45 INFO - 2015-11-14 17:07:45,137 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 117.0 115.0 121.0 117.0 119.0 111.0 122.0 121.0 17:07:45 INFO - 2015-11-14 17:07:45,137 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,137 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:1.00 17:07:45 INFO - 2015-11-14 17:07:45,137 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 75.0 73.0 74.0 73.0 75.0 74.0 74.0 73.0 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:82.00 stddev:1.37 (1.7%) stddev-sans-first:0.97 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 81.0 82.0 82.0 82.0 83.0 81.0 84.0 83.0 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:103.70 Median:104.00 stddev:4.47 (4.3%) stddev-sans-first:3.78 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: Values: 96.0 103.0 103.0 105.0 106.0 102.0 102.0 103.0 114.0 103.0 17:07:45 INFO - 2015-11-14 17:07:45,138 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:155.00 stddev:10.10 (6.5%) stddev-sans-first:10.06 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 158.0 168.0 152.0 145.0 163.0 170.0 144.0 147.0 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:181.50 stddev:5.29 (2.9%) stddev-sans-first:5.56 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: Values: 180.0 183.0 182.0 181.0 182.0 169.0 172.0 182.0 178.0 171.0 17:07:45 INFO - 2015-11-14 17:07:45,139 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,140 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:84.00 stddev:1.71 (2.0%) stddev-sans-first:1.30 17:07:45 INFO - 2015-11-14 17:07:45,140 DEBUG : BROWSER_OUTPUT: Values: 80.0 85.0 84.0 84.0 85.0 83.0 83.0 84.0 81.0 85.0 17:07:45 INFO - 2015-11-14 17:07:45,141 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:07:45 INFO - 2015-11-14 17:07:45,141 DEBUG : BROWSER_OUTPUT: 17:07:45 INFO - 2015-11-14 17:07:45,852 INFO : Browser exited with error code: 0 17:07:45 INFO - 2015-11-14 17:07:45,904 INFO : Completed test kraken (00:01:01) 17:07:45 INFO - 2015-11-14 17:07:45,904 INFO : Starting test v8_7 17:07:45 INFO - 2015-11-14 17:07:45,904 DEBUG : operating with platform_type : mac_ 17:07:45 INFO - 2015-11-14 17:07:45,904 INFO : Initialising browser for v8_7 test... 17:07:45 INFO - 2015-11-14 17:07:45,919 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmpWXcsCn/profile http://localhost:49267/getInfo.html 17:07:48 INFO - 2015-11-14 17:07:48,976 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:48 INFO - 2015-11-14 17:07:48,976 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:48 INFO - 2015-11-14 17:07:48,976 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:07:48 INFO - 2015-11-14 17:07:48,976 DEBUG : BROWSER_OUTPUT: __metrics 17:07:49 INFO - 2015-11-14 17:07:49,702 INFO : Browser initialized. 17:07:49 INFO - 2015-11-14 17:07:49,703 INFO : Running cycle 1/1 for v8_7 test... 17:07:49 INFO - 2015-11-14 17:07:49,703 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/T/tmpWXcsCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:08:01 INFO - 2015-11-14 17:08:01,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 241033216 17:08:01 INFO - 2015-11-14 17:08:01,855 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 261521408 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:08:24 INFO - 2015-11-14 17:08:24,625 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:08:24 INFO - 2015-11-14 17:08:24,626 DEBUG : BROWSER_OUTPUT: |0;Richards;187.02075930428276 17:08:24 INFO - 2015-11-14 17:08:24,626 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;223.61359570661895 17:08:24 INFO - 2015-11-14 17:08:24,626 DEBUG : BROWSER_OUTPUT: |2;Encrypt;356.8879371877231 17:08:24 INFO - 2015-11-14 17:08:24,626 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6972.222222222223 17:08:24 INFO - 2015-11-14 17:08:24,626 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1260.705289672544 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: |5;Earley;893.6550491510277 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: |6;Boyer;14428.57142857143 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: |7;RegExp;32580.645161290322 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: |8;Splay;722.543352601156 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6519.480519480519 17:08:24 INFO - 2015-11-14 17:08:24,627 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:08:24 INFO - 2015-11-14 17:08:24,628 DEBUG : BROWSER_OUTPUT: __startTimestamp1447549704624__endTimestamp 17:08:24 INFO - 2015-11-14 17:08:24,628 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,628 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:08:24 INFO - 2015-11-14 17:08:24,628 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:08:24 INFO - 2015-11-14 17:08:24,628 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:187.02 Median:187.02 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: Values: 187.0 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:223.61 Median:223.61 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: Values: 223.6 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,629 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:356.89 Median:356.89 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,630 DEBUG : BROWSER_OUTPUT: Values: 356.9 17:08:24 INFO - 2015-11-14 17:08:24,630 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,630 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,630 DEBUG : BROWSER_OUTPUT: Values: 6972.2 17:08:24 INFO - 2015-11-14 17:08:24,630 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1260.71 Median:1260.71 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: Values: 1260.7 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:893.66 Median:893.66 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: Values: 893.7 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,632 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14428.57 Median:14428.57 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: Values: 14428.6 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32580.65 Median:32580.65 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: Values: 32580.6 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: Values: 722.5 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-14 17:08:24,633 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6519.48 Median:6519.48 stddev:0.00 (0.0%) 17:08:24 INFO - 2015-11-14 17:08:24,634 DEBUG : BROWSER_OUTPUT: Values: 6519.5 17:08:24 INFO - 2015-11-14 17:08:24,634 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:08:24 INFO - 2015-11-14 17:08:24,634 DEBUG : BROWSER_OUTPUT: 17:08:25 INFO - 2015-11-14 17:08:25,337 INFO : Browser exited with error code: 0 17:08:25 INFO - 2015-11-14 17:08:25,358 INFO : Completed test v8_7 (00:00:39) 17:08:25 INFO - 2015-11-14 17:08:25,682 INFO : Completed test suite (00:20:14) 17:08:25 INFO - 2015-11-14 17:08:25,682 DEBUG : Working with test: dromaeo_css 17:08:25 INFO - 2015-11-14 17:08:25,682 DEBUG : Generating results file: dromaeo_css 17:08:25 INFO - 2015-11-14 17:08:25,683 DEBUG : Working with test: kraken 17:08:25 INFO - 2015-11-14 17:08:25,683 DEBUG : Generating results file: kraken 17:08:25 INFO - 2015-11-14 17:08:25,683 INFO : javascript benchmark 17:08:25 INFO - 2015-11-14 17:08:25,683 DEBUG : Working with test: v8_7 17:08:25 INFO - 2015-11-14 17:08:25,683 DEBUG : Generating results file: v8_7 17:08:25 INFO - 2015-11-14 17:08:25,684 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:26 INFO - 2015-11-14 17:08:26,838 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 17:08:26 INFO - 2015-11-14 17:08:26,838 DEBUG : process_Request line: dromaeo_css 5927.18 graph.html#tests=[[72,64,57]] 17:08:26 INFO - 2015-11-14 17:08:26,838 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:26 INFO - 2015-11-14 17:08:26,873 DEBUG : process_Request line: kraken 1782.40 graph.html#tests=[[232,64,57]] 17:08:26 INFO - 2015-11-14 17:08:26,873 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:26 INFO - 2015-11-14 17:08:26,908 DEBUG : process_Request line: v8_7 17318.73 graph.html#tests=[[230,64,57]] 17:08:26 INFO - 2015-11-14 17:08:26,909 INFO : javascript benchmark 17:08:26 INFO - 2015-11-14 17:08:26,911 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.8199157518127, 293.53035143769955, 297.01835433890983, 297.6874282003896, 304.38210432821376, 10377.792444151113, 10776.892231077707, 15246.161461119635, 15438.305276262567, 15754.527364179079, 10269.075783179513, 10279.897201027987, 10510.264281500298, 10539.104176145018, 10654.733631659212, 3828.4257361395876, 3937.645611894929, 3941.1920556286036, 3956.5845586213463, 3963.524377074755, 2982.5526171074403, 3922.235164142993, 3956.960430395688, 3960.9405858911996, 3995.5005624296964, 3958.6635136013474, 3962.2669806085823, 4006.9599304007024, 4111.48606424197, 4162.687798415131, 4130.834766609332, 4157.08544120293, 4179.874603761892, 4180.393842892794, 4187.120704652027, 3385.153711572107, 3488.9707536276605, 3508.824558772051, 3510.052285882823, 3548.556430446194, 9726.36778609388, 9920.503974801304, 11156.497957591928, 11542.07663386927, 11644.359560224184, 1541.537538738374, 1542.5680809373393, 1614.9757753633705, 1634.7302695055303, 1680.7478878168251, 8342.582870856433, 8444.0, 8479.788005299855, 8530.530820804854, 8565.486070835708, 1355.6068740065368, 1391.193107997359, 1418.6453386653336, 1429.4710956945892, 1440.272662305529, 46214.0, 48053.03893922102, 48619.27071093937, 48741.75629121867, 48974.51025489735, 5775.191473193672, 5808.215890854765, 5835.4748072673665, 5846.8538286542325, 5849.619774714715, 6548.967255163694, 6557.049227861933, 6622.768203112868, 6631.204255489372, 6633.668316584151, 4670.626349892001, 4681.274402467623, 4706.647001474903, 4752.1683705351425, 4756.5956893664425, 4905.901881962341, 4919.803207871717, 4933.186024306021, 4950.554450099508, 4985.077760614298, 2590.2617753940413, 2591.1449221756775, 2599.8440093594445, 2602.9479410411686, 2615.992842755553, 913.7578541686458, 916.4409710076848, 918.4305730447165, 926.2821313482106, 991.9931269761198, 350.2155172413775, 371.7750760789737, 380.29455360306787, 381.57073292545886, 396.13444623497173, 9860.30977831545, 10353.171746260281, 10480.161587073017, 10511.106555942677, 10688.839667404995, 402.30200601955585, 402.8086658837087, 412.79154027216066, 419.93910882922415, 420.9305464598368, 5514.09017512114, 5696.174054762037, 5708.086706127, 5727.3699893011735, 5744.569157313218, 491069.0, 492241.0, 504086.0, 504954.0, 505095.0, 63729.0, 64848.67575662091, 64945.350546494876, 65750.67124664442, 65913.34086659168, 420.2834167743989, 421.5510481337366, 425.47241420638807, 426.0286546673589, 426.1562107028102, 9587.568559414703, 9631.855522167032, 9657.9034209657, 9706.272029597667, 9714.174295184988, 28822.567661484674, 29848.104556863327, 30481.39037219199, 30517.0, 30563.847180763954, 41309.38035929403, 41660.58339416688, 42079.57920420756, 42437.57562424336, 42440.575594244896, 5426.945730542644, 5458.181272809111, 5510.559155267489, 5513.393526711979, 5516.558675306046, 10205.897941020792, 10283.485825708834, 10425.165986721197, 10515.474226288808, 10515.789684206426, 7616.961915190389, 8216.137305582828, 8882.022977472343, 8976.371653984419, 9174.449533028039, 8306.792330191794, 8508.404411691123, 8548.230659240699, 8621.13788621158, 8748.037715851378, 8703.97461010121, 8989.595468204077, 9068.546572671472, 9161.77095572616, 9258.0, 5393.460653934575, 5405.108157154025, 5421.349438067299, 5453.345598528202, 5473.698946557977, 8866.069062748318, 8960.596773145355, 9007.144321289466, 9046.0, 9120.49837258957], "dojo.html": [2804.565292379681, 2889.5954566360724, 2889.869955851988, 2929.443405752907, 2956.8225906445614, 4791.7604119794005, 4793.137235297645, 4820.060088282787, 4918.950810491894, 4940.678855874366, 4765.21373973294, 4776.90446191076, 4801.207800712887, 4841.370621819158, 4971.37857767779, 4473.172463094322, 4538.432695913011, 4612.884677883063, 4622.329762184481, 4642.466116396607, 749.6621281465468, 4340.262155433584, 4523.0, 4542.863714088583, 4628.537146285362, 4468.2850743881145, 4524.728516289, 4529.184746745585, 4539.886502837439, 4590.150822097889, 4589.632829373642, 4607.10161518504, 4609.446866376023, 4631.027484228282, 4674.018456124218, 4356.063446359017, 4463.33050042493, 4467.508574056851, 4595.9080818383445, 4629.953700462986, 4560.771961401917, 4681.953180468186, 4707.976460117712, 4777.402824646919, 4808.495108013643, 5041.218611115246, 5078.289039534468, 5081.085404627165, 5124.052050370693, 5136.974315128437, 5100.846974590768, 5107.055194788976, 5147.48525147486, 5173.405058418292, 5184.274201611777, 4887.169181239234, 4891.413030436371, 4904.0, 4905.2642103684375, 4967.130752118364, 5246.7638956247065, 5277.261183434322, 5285.524302812765, 5335.039692855324, 5359.08895487768, 4904.754762261944, 4988.975055124701, 5003.549680528697, 5052.166392545262, 5054.9241761373605, 5197.0, 5204.34945631796, 5210.47895210476, 5243.23973023917, 5303.681779093266, 5003.524665156804, 5084.51697088776, 5103.18349064148, 5178.0679477694375, 5178.741062946838, 5015.297858299841, 5102.897942041139, 5110.437851836295, 5126.307948426989, 5178.223266510054, 3983.143624120828, 4015.0765323975065, 4020.7386519876113, 4027.496562929634, 4044.029432936074, 3564.803935783557, 3633.218857945554, 3697.0942119180972, 3702.22253326799, 3741.9251614967548, 4791.185498465269, 4800.135975524439, 4804.327394164819, 4855.32025516428, 4869.732164730903, 5205.9219111713355, 5211.270422140903, 5222.399424066281, 5246.449122842123, 5249.580033597303, 4635.95364046362, 4714.175019371596, 4753.120672675566, 4822.373091498082, 4890.975545122252, 4512.345709872116, 4522.479914809774, 4557.45310562728, 4583.633309335311, 4607.95392046082, 5333.546648534841, 5380.273663055437, 5395.433479484676, 5398.811041613525, 5414.3502779665905, 5073.720945347894, 5078.669886457368, 5094.032133894548, 5168.431472537943, 5263.710495922761, 5228.294180285613, 5243.003829272426, 5266.262723218676, 5295.602829787705, 5321.2816269804625, 5055.696658200372, 5108.821191258288, 5111.923321150111, 5116.948830511647, 5123.077845987758, 5091.312672789126, 5094.898102037864, 5153.510416510426, 5157.535821776059, 5180.404253510744, 5008.924866127084, 5075.365579302587, 5138.177891537336, 5138.640295179451, 5143.125668636416, 5006.274090256819, 5080.11098057831, 5136.948630513647, 5140.794368225229, 5174.0, 4724.385829842098, 4829.251466022632, 4903.190973489477, 4991.051700176955, 5017.623678224075, 4902.485239049848, 4981.3026176334615, 5065.544101030925, 5089.1094058538865, 5112.872178195426, 4957.950420495749, 4965.627577931597, 4979.526944940225, 5005.0, 5052.520010598987], "mootools.html": [1280.5966120671985, 1414.4483651375958, 1478.209158100416, 1643.7863077799884, 1643.8931469454492, 6275.843103922392, 6406.295307516181, 6797.048413222153, 6871.55334903231, 6958.791236262914, 6697.2967838377, 6915.827104322394, 7019.333163349474, 7020.578765274087, 7021.578705277687, 1980.1089509720612, 2002.429307647321, 2010.4169790760734, 2020.7878172791793, 2023.9880059970014, 1977.9011049447543, 2015.3147929703898, 2036.531597732515, 2104.8947552622385, 2110.5040315525916, 1948.6492431362349, 1983.1373352591597, 1997.0613811508567, 2001.3495613925459, 2010.497375656086, 2035.9389218323474, 2044.7648520420119, 2053.117159621362, 2054.0, 2065.834733221339, 1961.4900125967208, 1990.1243452880685, 2013.456366780961, 2015.54650203703, 2038.7553493580717, 6664.966675166642, 6665.300143484913, 6688.531802773808, 6701.128853249095, 6705.798826035227, 4311.094670119279, 4330.935035974463, 4378.277584198603, 4381.036172042146, 4425.092855964552, 2384.165542060265, 2473.863937483438, 2664.0542607374296, 2734.8359098454157, 2777.6389069421048, 788.2669117720518, 822.3298012120163, 826.8925039744795, 833.6582001379466, 833.8999320081568, 9539.284553658434, 9546.284028697806, 9561.187299079587, 9611.519424028771, 9629.229661627123, 3922.7646341219047, 3926.411038344271, 3940.4483372327895, 3966.9884179534033, 3998.520177578709, 8162.959185204036, 8185.549794761227, 8192.795180120545, 8276.462029968034, 8306.377021723274, 4395.648348132142, 4397.054633253866, 4412.977935110368, 4426.269665505156, 4434.17967675981, 3992.5208974923194, 4019.8995025124605, 4022.7586344819406, 4031.213913286881, 4062.106336605942, 3309.6028476582965, 3382.374260761767, 3391.609964854024, 3415.4023045966856, 3442.4836274558515, 1104.817705078653, 1119.8992090711874, 1121.876593574706, 1132.2300835431986, 1136.9886301137049, 938.1181689212119, 962.9614815407306, 966.989495976706, 1018.6842078955548, 1210.4189988805422, 6636.2368327642935, 6676.365745254193, 6687.732490700415, 6690.330966903271, 6764.76323328691, 424.94688163979504, 425.090306743569, 429.45673722740133, 430.70927124191047, 431.7193824014416, 5171.663841850343, 5216.58267338612, 5228.2680424740565, 5260.395054568774, 5307.495787900143, 8018.198180181935, 8316.833663326699, 8344.290735287446, 8371.874421883676, 8485.830283394422, 8245.752627421187, 8276.751697449086, 8299.087100418948, 8331.875021874677, 8393.412461127662, 6491.734111848239, 6564.8030559082345, 6577.539572229994, 6583.736650533925, 6698.832529186712, 6307.90538141919, 6314.242290925118, 6332.968335158294, 6352.110704501281, 6408.0, 7152.320529549893, 7175.820604484929, 7325.157606875277, 7356.558606483628, 7387.630618468947, 7398.186199518156, 7591.696332146652, 7677.923220767944, 7716.807079823049, 7718.614069296625, 6141.109539116893, 6165.6608886509875, 6165.815025549241, 6167.259928808572, 6230.813075607739, 6630.469562434897, 6698.430633396216, 6725.260221375743, 6743.15710536183, 6796.864062718619, 6271.498280137487, 6297.55917085818, 6311.589746666452, 6348.809535713936, 6385.0, 6047.546434017554, 6121.112438696453, 6143.539234557336, 6199.3490683477585, 6239.688015599293, 6233.314335423191, 6267.341929097562, 6301.243850737941, 6323.683815809283, 6357.618542887441, 5711.257536520392, 5769.653820770767, 5770.596058275881, 5844.590878638624, 5856.531477481706, 5364.275822763877, 5399.0, 5509.090999984957, 5806.187133801355, 5928.67392293428], "ext.html": [492.97781599828005, 501.3307234841486, 505.43138968660236, 514.899594579057, 523.2021167719225, 33030.339393212154, 33694.32611347771, 33724.32551348975, 33759.66240337596, 33760.4935925961, 37099.62900370995, 37712.62287377125, 37744.81127594365, 37930.8103459483, 38086.23827523448, 8260.463069900452, 8304.418690691655, 8403.243708066273, 8421.536815475147, 8424.326053915702, 8141.674333026672, 8273.172682731709, 8274.710385136521, 8286.378521610874, 8299.875501867476, 8271.090180080186, 8355.456895301817, 8368.37237207212, 8370.58147092646, 8382.916170838305, 8236.958815205915, 8344.0, 8349.29031032363, 8349.707760228424, 8361.916380836235, 8076.434649574532, 8235.917640823574, 8249.752507424726, 8257.256846883809, 8257.8348433031, 35423.64576354255, 36292.637073629456, 36327.09182270438, 36351.4547281791, 36486.45270320947, 2567.435164263859, 2606.504764094816, 2640.0891692366104, 2651.615515750225, 2971.939408989322, 24329.878350608134, 24390.756092439027, 24894.875525622436, 25415.0, 25775.613365799527, 2170.2295685031745, 2182.2034957240653, 2212.668099785029, 2214.0368939511204, 2214.169686367612, 236805.0, 241093.0, 241607.99999999825, 243891.0, 244428.0, 44712.55287447149, 51228.0, 51512.48487515152, 51595.484045159064, 52113.47886521162, 42118.57881421208, 60299.0, 61019.0, 61335.07997380043, 61504.0, 12835.679108022186, 12946.546870859474, 13047.956163506897, 13131.34343282832, 13140.408681609159, 8652.04827468978, 8663.610137543825, 8674.653013879373, 8674.86987695185, 8683.392162548562, 17002.489925302012, 17209.397671081704, 17229.39697110595, 17283.481495555152, 17364.91317543404, 7199.172095209014, 7258.0927384076995, 7347.926520734724, 7389.593572353572, 7402.778541540585, 843.42225575481, 881.272949816404, 900.5497251374313, 980.4509474694194, 1029.3463650581934, 24489.0, 25279.185787268663, 25361.49277014486, 25396.0, 25837.483250334888, 939.0187254319253, 1007.7531004903699, 1070.91302328137, 1121.9102471802237, 1124.3703526025288, 13170.275634839983, 13259.403326850315, 13411.932940335237, 13600.251986140856, 13921.0, 282088.0, 285487.0, 285583.0, 286384.0, 288223.0, 49087.50912490829, 49279.260811087865, 49294.50705492971, 49618.0, 49669.0, 1235.2279825109306, 1244.595506460404, 1248.2572869142846, 1248.887600115994, 1253.1854294708512, 25424.491510169322, 26067.217983460527, 26191.214263572125, 26240.60639090377, 26638.0, 42287.788561057, 42987.78506107449, 43039.784801075795, 43124.56875431331, 43394.78302608467, 254630.0, 256049.0, 257388.0, 257604.0, 257722.0, 26321.341966450225, 26581.335466612716, 26804.463910722065, 26843.19470415891, 27111.0, 36710.44934325934, 37417.251654967295, 37609.81195094007, 37923.431148533346, 38210.426843597925, 30892.845535773078, 31421.52867707032, 31849.36301274008, 33642.831785840914, 34018.489722653685, 30993.69006309998, 30994.535081974238, 31015.534766978966, 31032.68967310298, 31063.68936310608, 31926.6807331933, 32439.351212976082, 32609.18477038093, 32649.836750816095, 32902.50646240356, 26134.0, 26641.467170656866, 27163.72836271612, 28006.57990130109, 28316.0, 20453.897730511253, 20568.38401208776, 21393.144274228856, 21426.892865535574, 21504.354869353945], "prototype.html": [277.53789939750317, 282.94624021435925, 287.79997901458484, 288.4591391141611, 293.54500524187506, 5689.971550142249, 5711.885762284752, 5742.942570574293, 5773.5092517136045, 5795.304563452381, 5617.606767526275, 5718.59969802114, 5796.101604251337, 5796.333421656511, 5808.099744539592, 4445.799634098791, 4459.710118842281, 4460.7323560586465, 4483.170613436525, 4493.595576398124, 4337.54455782143, 4451.732896026248, 4455.84404545841, 4472.329150627399, 4480.238359478896, 4315.180115778008, 4380.08018316154, 4388.67084968627, 4410.71330363527, 4429.357743127244, 4368.322909948963, 4382.561743825624, 4413.6910416270875, 4429.446319210083, 4434.512203657595, 3770.8491660333552, 3776.3013842438963, 3819.8281077351585, 3826.6747326477284, 3833.7891415972113, 5354.170103633943, 5377.8117765878005, 5509.917351239735, 5555.916661250085, 5579.525740312079, 4834.516548345173, 4843.07981483517, 4877.707337559757, 4887.853364399074, 4898.624167278903, 5953.970230148865, 6025.668588227646, 6026.9095963560585, 6031.6079454835735, 6055.212822333113, 3930.1353702185475, 3985.80070996449, 4031.455753473273, 4033.072393349517, 4034.677225821927, 6113.908291375633, 6277.937220627827, 6281.0, 6309.905351419732, 6330.240371155444, 4160.251154792106, 4162.687798415131, 4192.601702838226, 4198.223328684203, 4203.390508376329, 4225.070484493406, 4234.745915245096, 4271.423357846713, 4274.850380236677, 4282.100758840616, 4896.045271172158, 4904.2643603459765, 4916.901661966741, 4935.975320123448, 4947.604191664658, 5793.0, 5979.880402391927, 6043.153958445733, 6044.546659000593, 6062.393760623991, 1485.7548504496854, 1489.240487351437, 1489.9793641355707, 1506.9623259418602, 1510.3128076725063, 959.5298303831212, 983.9065288797696, 990.4008075114596, 991.5570390732463, 996.5117092624706, 5614.9719251403485, 5629.24005259293, 5636.0, 5638.323401191883, 5703.800366987219, 6204.844878877974, 6205.2553693557065, 6234.844128896814, 6245.718942647592, 6274.1843560336865, 5601.887962240814, 5611.8597035073635, 5692.31692196939, 5693.629914055573, 5696.914546281809, 3271.362084393568, 3373.730101591867, 3405.897823065312, 3417.0432278961434, 3455.2053027803745, 6500.187476565429, 6503.4146926775875, 6512.185976752906, 6524.739010439529, 6529.5102867284195, 6220.191375121205, 6291.182146320949, 6333.556651034383, 6344.555881088372, 6515.413612774873, 6386.10594516768, 6440.967795160994, 6509.479241660656, 6511.674416279167, 6514.315996820361, 6259.499240060875, 6323.588966717149, 6330.240371155307, 6345.90481142774, 6363.172787537591, 5972.850678732892, 6168.414000669929, 6210.720517576629, 6234.2830574484515, 6237.313895471585, 6415.1981002374705, 6441.67791610427, 6501.1548498694865, 6512.902306465501, 6524.314946930694, 3947.6052394760295, 3956.663683586927, 3978.3634618460906, 4013.0569316210085, 4026.2148880969103, 6048.939510604838, 6249.281332646804, 6253.843653908689, 6295.811125666238, 6338.049292605961, 6075.665838378932, 6077.301110372364, 6111.449969502766, 6142.078688196806, 6155.076738489262, 6055.333913269449, 6066.575339726177, 6105.938940610715, 6126.969365153146, 6142.201513803356, 5641.633293835887, 5855.707214639166, 5945.583809133319, 5951.047832346804, 5960.463558279602, 6053.213082299273, 6061.727222275096, 6115.113308570321, 6116.082587611894, 6137.570370074052, 5937.198478205387, 5939.10913362999, 6001.849953751192, 6019.638821670714, 6029.60807547508], "yui.html": [552.1221258199463, 620.6896551724138, 655.5607742812315, 667.6066302306232, 676.7462201674372, 11493.655190344281, 11961.521539138446, 12254.693632659188, 12721.236725796458, 12744.872551274484, 11021.393823339713, 11152.553897844076, 11203.327800331987, 11221.60724374647, 11273.661790146309, 755.5768769489076, 762.1692355332673, 780.7813812132583, 781.2460975158971, 791.2720297326445, 792.4848848248656, 801.2388231180373, 802.0215337288528, 804.4127786715701, 813.1989989860012, 829.5022986208287, 831.4927893984665, 832.8375966686499, 836.9539675317855, 842.7050532313672, 826.4297634632085, 826.7726375246795, 827.9503229806231, 830.2527725047476, 833.7123692326138, 614.735663664624, 614.978475753351, 616.9912193563556, 618.5917294585597, 620.2804746494045, 11825.704357391049, 11919.404029798563, 12398.938005310007, 12411.379431028503, 12424.627261182179, 10160.187185025181, 10314.12329951955, 10436.843447348296, 10531.104856087166, 10707.678769636923, 8188.754337369829, 8214.219649133323, 8334.541600211985, 8443.620037098346, 8802.647894084294, 2874.5831854381, 2908.679380143543, 2949.7492713119195, 2960.4375168717875, 3019.124453908364, 42399.36400953988, 42926.57073429288, 43251.78374108141, 43513.34729979053, 43639.563604364186, 7727.690892364242, 7905.802354941173, 7932.643031063616, 7995.320397766139, 8254.092049874509, 16543.172841357886, 16638.0, 16679.91660041692, 16708.331666733437, 16711.080890551137, 5475.370332411744, 5625.268715067097, 6437.324080971524, 6459.644719540376, 6608.041833934052, 3417.1627951152127, 3435.2270739084006, 3526.1360966563357, 3594.7843129412317, 3615.9276814463565, 2711.498372801038, 2747.5191841427672, 2775.4865349910333, 2777.652793400825, 2781.3880946191807, 396.8096504107005, 404.34219699233495, 407.8001779128206, 416.7020580285111, 420.459709273582, 458.8325261279609, 506.06630766236236, 510.5328624308716, 526.7682219823265, 562.3954249182063, 6822.556533825285, 6987.336203060701, 7123.358897699232, 7232.74685386009, 7245.748566246626, 506.60484821839026, 514.369896876331, 541.656048409263, 544.9400565937743, 554.967759966462, 3199.0, 3442.4836274558515, 3655.817209139532, 3701.722370822199, 3852.6917846572205, 52388.214176787376, 53253.46746532485, 53582.7320863401, 53789.73105134449, 53818.0, 44602.33096503555, 45480.317795233095, 45714.77142614266, 45777.0, 45873.0, 44719.32921006188, 44936.3259551107, 45584.54415455803, 45862.77068614702, 46403.0, 7251.56490610565, 7252.383547398319, 7294.781156565312, 7625.275598818103, 7675.654595543102, 27744.861275693493, 27891.721082788914, 28333.291667708472, 28503.0, 28608.284792880346, 36454.635453645125, 36722.08194795045, 40514.18971620492, 41388.586114138474, 41634.79182604067, 9067.319951003568, 9480.0, 9733.37839987291, 9827.950860245654, 10022.0, 9756.170725488413, 9928.602855885973, 9970.50147492637, 10059.094681478702, 10183.84724229152, 9379.812403752023, 9666.178374837937, 9723.173530250007, 9732.41605503672, 9747.415155090717, 9438.150566449052, 9651.951740241253, 9735.853962190431, 9786.510674466106, 9799.412035277906, 8678.0, 8890.955545222232, 9377.0, 9450.291228158054, 9616.230701544, 8104.635291412019, 8203.179682031989, 8518.318534517348, 8600.311975042106, 8623.525706086226, 8183.83632327362, 8193.83612327762, 8236.546989915612, 8248.46384984974, 8341.45780524264]}, "summary": {"lowerIsBetter": false, "suite": 5927.1821316182495, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5750.847755750452, "unit": "ms", "value": 5750.847755750452}, "dojo.html": {"lowerIsBetter": false, "filtered": 4765.040131312663, "unit": "ms", "value": 4765.040131312663}, "mootools.html": {"lowerIsBetter": false, "filtered": 3928.406225007651, "unit": "ms", "value": 3928.406225007651}, "ext.html": {"lowerIsBetter": false, "filtered": 16289.740821570113, "unit": "ms", "value": 16289.740821570113}, "prototype.html": {"lowerIsBetter": false, "filtered": 4521.076973311146, "unit": "ms", "value": 4521.076973311146}, "yui.html": {"lowerIsBetter": false, "filtered": 5468.636150110073, "unit": "ms", "value": 5468.636150110073}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0107.e"}, "testrun": {"date": 1447548491, "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": "20151114144431", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}, {"talos_counters": {}, "results": {"audio-dft": [188.0, 191.0, 194.0, 197.0, 193.0, 193.0, 193.0, 192.0, 195.0, 195.0], "ai-astar": [127.0, 115.0, 126.0, 126.0, 128.0, 140.0, 125.0, 128.0, 129.0, 125.0], "imaging-gaussian-blur": [142.0, 135.0, 143.0, 135.0, 143.0, 135.0, 138.0, 150.0, 143.0, 142.0], "audio-beat-detection": [177.0, 153.0, 179.0, 187.0, 151.0, 172.0, 171.0, 176.0, 189.0, 150.0], "json-stringify-tinderbox": [79.0, 82.0, 81.0, 82.0, 82.0, 82.0, 83.0, 81.0, 84.0, 83.0], "stanford-crypto-pbkdf2": [180.0, 183.0, 182.0, 181.0, 182.0, 169.0, 172.0, 182.0, 178.0, 171.0], "json-parse-financial": [67.0, 72.0, 75.0, 73.0, 74.0, 73.0, 75.0, 74.0, 74.0, 73.0], "stanford-crypto-sha256-iterative": [80.0, 85.0, 84.0, 84.0, 85.0, 83.0, 83.0, 84.0, 81.0, 85.0], "audio-fft": [81.0, 84.0, 95.0, 131.0, 79.0, 78.0, 82.0, 90.0, 135.0, 78.0], "imaging-darkroom": [149.0, 150.0, 150.0, 149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0], "stanford-crypto-ccm": [144.0, 148.0, 158.0, 168.0, 152.0, 145.0, 163.0, 170.0, 144.0, 147.0], "audio-oscillator": [99.0, 104.0, 149.0, 101.0, 105.0, 105.0, 144.0, 104.0, 104.0, 147.0], "stanford-crypto-aes": [96.0, 103.0, 103.0, 105.0, 106.0, 102.0, 102.0, 103.0, 114.0, 103.0], "imaging-desaturate": [122.0, 118.0, 117.0, 115.0, 121.0, 117.0, 119.0, 111.0, 122.0, 121.0]}, "summary": {"lowerIsBetter": true, "suite": 1782.4000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.3, "unit": "ms", "value": 93.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 178.0, "unit": "ms", "value": 178.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 170.5, "unit": "ms", "value": 170.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 153.9, "unit": "ms", "value": 153.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.6, "unit": "ms", "value": 149.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.0, "unit": "ms", "value": 73.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 116.2, "unit": "ms", "value": 116.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 126.9, "unit": "ms", "value": 126.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 193.1, "unit": "ms", "value": 193.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 83.4, "unit": "ms", "value": 83.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 81.9, "unit": "ms", "value": 81.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 140.6, "unit": "ms", "value": 140.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 103.7, "unit": "ms", "value": 103.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 118.3, "unit": "ms", "value": 118.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0107.e"}, "testrun": {"date": 1447548491, "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": "20151114144431", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [223.61359570661895], "Encrypt": [356.8879371877231], "NavierStokes": [6519.480519480519], "Decrypt": [6972.222222222223], "Splay": [722.543352601156], "Richards": [187.02075930428276], "RegExp": [32580.645161290322], "Earley": [893.6550491510277], "Boyer": [14428.57142857143], "RayTrace": [1260.705289672544]}, "summary": {"lowerIsBetter": false, "suite": 17318.728268084626, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 295.67969600000004, "unit": "score", "value": 295.67969600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 745.8391620000001, "unit": "score", "value": 745.8391620000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 227.6254980079681, "unit": "score", "value": 227.6254980079681}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.177354581673285, "unit": "score", "value": 38.177354581673285}, "Splay": {"lowerIsBetter": false, "filtered": 112.78354399999998, "unit": "score", "value": 112.78354399999998}, "RegExp": {"lowerIsBetter": false, "filtered": 27.960925742574254, "unit": "score", "value": 27.960925742574254}, "Richards": {"lowerIsBetter": false, "filtered": 188.7597940000001, "unit": "score", "value": 188.7597940000001}, "Earley": {"lowerIsBetter": false, "filtered": 745.772097, "unit": "score", "value": 745.772097}, "Boyer": {"lowerIsBetter": false, "filtered": 46.190504950495075, "unit": "score", "value": 46.190504950495075}, "RayTrace": {"lowerIsBetter": false, "filtered": 586.9643016983016, "unit": "score", "value": 586.9643016983016}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0107.e"}, "testrun": {"date": 1447548491, "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": "20151114144431", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}] 17:08:26 INFO - RETURN: dromaeo_css: 5927.18 17:08:26 INFO - RETURN: kraken: 1782.40 17:08:26 INFO - RETURN: v8_7: 17318.73 17:08:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "17318.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1782.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5927.18"}}} 17:08:27 INFO - Return code: 0 17:08:27 INFO - # TBPL SUCCESS # 17:08:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:08:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:08:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:08:27 INFO - 2015-11-14 17:08:27.047 screenresolution[1665:10937] starting screenresolution argv=screenresolution get 17:08:27 INFO - 2015-11-14 17:08:27.051 screenresolution[1665:10937] Display 0: 1600x1200x32@60 17:08:27 INFO - 2015-11-14 17:08:27.057 screenresolution[1666:10941] starting screenresolution argv=screenresolution list 17:08:27 INFO - Available Modes on Display 0 17:08:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:08:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:08:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:08:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:08:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:08:27 INFO - Intel HD Graphics 3000: 17:08:27 INFO - Chipset Model: Intel HD Graphics 3000 17:08:27 INFO - Type: GPU 17:08:27 INFO - Bus: Built-In 17:08:27 INFO - VRAM (Total): 512 MB 17:08:27 INFO - VRAM (Dynamic, Max): 10 17:08:27 INFO - Vendor: Intel (0x8086) 17:08:27 INFO - Device ID: 0x0116 17:08:27 INFO - Revision ID: 0x0009 17:08:27 INFO - Displays: 17:08:27 INFO - Display: 17:08:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:08:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:08:27 INFO - Display Serial Number: 1600x1200 60 17:08:27 INFO - Main Display: Yes 17:08:27 INFO - Mirror: Off 17:08:27 INFO - Online: Yes 17:08:27 INFO - Rotation: Supported 17:08:27 INFO - Return code: 0 17:08:27 INFO - Running post-action listener: _resource_record_post_action 17:08:27 INFO - Running post-run listener: _resource_record_post_run 17:08:28 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 39224320; Write bytes: 688970752; Read time: 5198; Write time: 31778 17:08:28 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 338762240; Write bytes: 334698496; Read time: 35165; Write time: 6630 17:08:28 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 37262336; Write bytes: 342987776; Read time: 4864; Write time: 24071 17:08:28 INFO - Running post-run listener: _upload_blobber_files 17:08:28 INFO - Blob upload gear active. 17:08:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:08:28 INFO - Copying logs to upload dir... 17:08:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1321.481510 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-11-14 17:08:28.485463) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 17:08:28.489057) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010347 build_url: 'https://queue.taskcluster.net/v1/task/vPuJzxHWSvWnKT2De8NPTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 17:08:28.515422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 17:08:28.515760) ========= 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.wAMNNWZ4on/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.7zRru1Qp59/Listeners TMPDIR=/var/folders/t7/tr0n99k95vs0nfwwm3rvy0t800000w/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.005446 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 17:08:28.565217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 17:08:28.565529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 17:08:28.565989) ========= ========= Total master_lag: 0.75 =========