builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0015 starttime: 1447933564.93 results: success (0) buildid: 20151119005437 builduid: b7d33a646d254966822b69bd799235b0 revision: 3a6d7dcaaae54d3216f8b93d437a07a55ea44ced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.930067) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.930525) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.930819) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005423 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.955109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.958479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.978449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:04.978847) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005705 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.028294) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.028618) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.028982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.029302) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False --2015-11-19 03:46:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2015-11-19 03:46:05 (8.31 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.239725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.240072) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.032994 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:05.288874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 03:46:05.289216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3a6d7dcaaae54d3216f8b93d437a07a55ea44ced --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 3a6d7dcaaae54d3216f8b93d437a07a55ea44ced --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False 2015-11-19 03:46:05,368 truncating revision to first 12 chars 2015-11-19 03:46:05,368 Setting DEBUG logging. 2015-11-19 03:46:05,368 attempt 1/10 2015-11-19 03:46:05,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3a6d7dcaaae5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 03:46:06,968 unpacking tar archive at: fx-team-3a6d7dcaaae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.840725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 03:46:07.147119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:07.147460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:07.158905) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:07.159264) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 03:46:07.159716) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-19 03:46:07.160007) ========= /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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False 03:46:07 INFO - MultiFileLogger online at 20151119 03:46:07 in /builds/slave/test 03:46:07 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 03:46:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:46:07 INFO - {'append_to_log': False, 03:46:07 INFO - 'base_work_dir': '/builds/slave/test', 03:46:07 INFO - 'blob_upload_branch': 'Fx-Team', 03:46:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:46:07 INFO - 'branch': 'Fx-Team', 03:46:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:07 INFO - 'config_files': ('talos/mac_config.py',), 03:46:07 INFO - 'default_actions': ('clobber', 03:46:07 INFO - 'read-buildbot-config', 03:46:07 INFO - 'download-and-extract', 03:46:07 INFO - 'populate-webroot', 03:46:07 INFO - 'create-virtualenv', 03:46:07 INFO - 'install', 03:46:07 INFO - 'run-tests'), 03:46:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:07 INFO - 'download_minidump_stackwalk': True, 03:46:07 INFO - 'download_symbols': 'ondemand', 03:46:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:07 INFO - 'installer_path': 'installer.exe', 03:46:07 INFO - 'log_level': 'info', 03:46:07 INFO - 'log_name': 'talos', 03:46:07 INFO - 'log_to_console': True, 03:46:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:46:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:46:07 INFO - 'opt_config_files': (), 03:46:07 INFO - 'pip_index': False, 03:46:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:46:07 INFO - 'cmd': ('bash', 03:46:07 INFO - '-c', 03:46:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:46:07 INFO - 'enabled': True, 03:46:07 INFO - 'halt_on_failure': False, 03:46:07 INFO - 'name': 'check_screen_resolution'},), 03:46:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:46:07 INFO - 'cmd': ('bash', 03:46:07 INFO - '-c', 03:46:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:46:07 INFO - 'enabled': True, 03:46:07 INFO - 'halt_on_failure': False, 03:46:07 INFO - 'name': 'check_screen_resolution'},), 03:46:07 INFO - 'run_cmd_checks_enabled': True, 03:46:07 INFO - 'sps_profile': False, 03:46:07 INFO - 'sps_profile_interval': 0, 03:46:07 INFO - 'suite': 'dromaeojs-e10s', 03:46:07 INFO - 'system_bits': '64', 03:46:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:07 INFO - 'title': 't-yosemite-r7-0015', 03:46:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:07 INFO - 'use_talos_json': True, 03:46:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:46:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:07 INFO - 'work_dir': 'build'} 03:46:07 INFO - ##### 03:46:07 INFO - ##### Running clobber step. 03:46:07 INFO - ##### 03:46:07 INFO - Running pre-action listener: _resource_record_pre_action 03:46:07 INFO - Running main action method: clobber 03:46:07 INFO - rmtree: /builds/slave/test/build 03:46:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:46:08 INFO - Running post-action listener: _resource_record_post_action 03:46:08 INFO - ##### 03:46:08 INFO - ##### Running read-buildbot-config step. 03:46:08 INFO - ##### 03:46:08 INFO - Running pre-action listener: _resource_record_pre_action 03:46:08 INFO - Running main action method: read_buildbot_config 03:46:08 INFO - Using buildbot properties: 03:46:08 INFO - { 03:46:08 INFO - "properties": { 03:46:08 INFO - "buildnumber": 1, 03:46:08 INFO - "product": "firefox", 03:46:08 INFO - "script_repo_revision": "production", 03:46:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:46:08 INFO - "repository": "", 03:46:08 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:46:08 INFO - "buildid": "20151119005437", 03:46:08 INFO - "slavename": "t-yosemite-r7-0015", 03:46:08 INFO - "pgo_build": "False", 03:46:08 INFO - "basedir": "/builds/slave/test", 03:46:08 INFO - "project": "", 03:46:08 INFO - "platform": "yosemite_r7", 03:46:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:46:08 INFO - "slavebuilddir": "test", 03:46:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:46:08 INFO - "branch": "fx-team", 03:46:08 INFO - "repo_path": "integration/fx-team", 03:46:08 INFO - "stage_platform": "macosx64", 03:46:08 INFO - "builduid": "b7d33a646d254966822b69bd799235b0", 03:46:08 INFO - "revision": "3a6d7dcaaae54d3216f8b93d437a07a55ea44ced" 03:46:08 INFO - }, 03:46:08 INFO - "sourcestamp": { 03:46:08 INFO - "repository": "", 03:46:08 INFO - "hasPatch": false, 03:46:08 INFO - "project": "", 03:46:08 INFO - "branch": "fx-team-macosx64-talos", 03:46:08 INFO - "changes": [ 03:46:08 INFO - { 03:46:08 INFO - "category": null, 03:46:08 INFO - "files": [ 03:46:08 INFO - { 03:46:08 INFO - "url": null, 03:46:08 INFO - "name": "https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:46:08 INFO - } 03:46:08 INFO - ], 03:46:08 INFO - "repository": "", 03:46:08 INFO - "rev": "3a6d7dcaaae54d3216f8b93d437a07a55ea44ced", 03:46:08 INFO - "who": "gijskruitbosch@gmail.com", 03:46:08 INFO - "when": 1447929500, 03:46:08 INFO - "number": 6681883, 03:46:08 INFO - "comments": "Bug 1040005 - fix nsHelperAppDlg.js to cope with always ask in combination with a preferred helper app, r=mconley", 03:46:08 INFO - "project": "", 03:46:08 INFO - "at": "Thu 19 Nov 2015 02:38:20", 03:46:08 INFO - "branch": "fx-team-macosx64-talos", 03:46:08 INFO - "revlink": "", 03:46:08 INFO - "properties": [ 03:46:08 INFO - [ 03:46:08 INFO - "buildid", 03:46:08 INFO - "20151119005437", 03:46:08 INFO - "Change" 03:46:08 INFO - ], 03:46:08 INFO - [ 03:46:08 INFO - "builduid", 03:46:08 INFO - "b7d33a646d254966822b69bd799235b0", 03:46:08 INFO - "Change" 03:46:08 INFO - ], 03:46:08 INFO - [ 03:46:08 INFO - "pgo_build", 03:46:08 INFO - "False", 03:46:08 INFO - "Change" 03:46:08 INFO - ] 03:46:08 INFO - ], 03:46:08 INFO - "revision": "3a6d7dcaaae54d3216f8b93d437a07a55ea44ced" 03:46:08 INFO - } 03:46:08 INFO - ], 03:46:08 INFO - "revision": "3a6d7dcaaae54d3216f8b93d437a07a55ea44ced" 03:46:08 INFO - } 03:46:08 INFO - } 03:46:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:46:08 INFO - Running post-action listener: _resource_record_post_action 03:46:08 INFO - ##### 03:46:08 INFO - ##### Running download-and-extract step. 03:46:08 INFO - ##### 03:46:08 INFO - Running pre-action listener: _resource_record_pre_action 03:46:08 INFO - Running main action method: download_and_extract 03:46:08 INFO - mkdir: /builds/slave/test/build/tests 03:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:08 INFO - https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/test_packages.json 03:46:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/test_packages.json 03:46:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:46:10 INFO - Downloaded 1149 bytes. 03:46:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:46:10 INFO - Using the following test package requirements: 03:46:10 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:46:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:46:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'jsshell-mac.zip'], 03:46:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:46:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:46:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:46:10 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:46:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:46:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:46:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:46:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:46: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')]} 03:46:10 INFO - https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:46:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:11 INFO - Downloaded 17477459 bytes. 03:46:11 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 03:46:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:46:14 INFO - Return code: 0 03:46:14 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 03:46:14 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')]} 03:46:14 INFO - https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:15 INFO - Downloaded 17477459 bytes. 03:46:15 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 03:46:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:46:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:46:18 INFO - Return code: 0 03:46: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')]} 03:46:18 INFO - https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:19 INFO - Downloaded 11130997 bytes. 03:46:19 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 03:46:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:46:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:46:19 INFO - Return code: 0 03:46:19 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')]} 03:46:19 INFO - https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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 03:46:23 INFO - Downloaded 108852643 bytes. 03:46:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:46:23 INFO - mkdir: /builds/slave/test/properties 03:46:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:46:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:46:23 INFO - Contents: 03:46:23 INFO - build_url:https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:46:23 INFO - Running post-action listener: _resource_record_post_action 03:46:23 INFO - Running post-action listener: set_extra_try_arguments 03:46:23 INFO - ##### 03:46:23 INFO - ##### Running populate-webroot step. 03:46:23 INFO - ##### 03:46:23 INFO - Running pre-action listener: _resource_record_pre_action 03:46:23 INFO - Running main action method: populate_webroot 03:46:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:46:23 INFO - '../fennec_ids.txt'], 03:46:23 INFO - 'tests': ['tcheck2']}, 03:46:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:23 INFO - '--tppagecycles', 03:46:23 INFO - '7'], 03:46:23 INFO - 'tests': ['tsvgm']}}, 03:46:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'tests': ['damp', 'tps']}, 03:46:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['damp', 'tps']}, 03:46:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:23 INFO - 'other': {'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'other_l64': {'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:23 INFO - 'ts_paint', 03:46:23 INFO - 'tpaint', 03:46:23 INFO - 'sessionrestore', 03:46:23 INFO - 'sessionrestore_no_auto_restore']}, 03:46:23 INFO - 'svgr': {'tests': ['tsvgx', 03:46:23 INFO - 'tsvgr_opacity', 03:46:23 INFO - 'tart', 03:46:23 INFO - 'tscrollx', 03:46:23 INFO - 'cart']}, 03:46:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['tsvgx', 03:46:23 INFO - 'tsvgr_opacity', 03:46:23 INFO - 'tart', 03:46:23 INFO - 'tscrollx', 03:46:23 INFO - 'cart']}, 03:46:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'tests': ['tp5o']}, 03:46:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'talos_options': ['--e10s'], 03:46:23 INFO - 'tests': ['tp5o']}, 03:46:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'talos_options': ['--xperf_path', 03:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:23 INFO - 'tests': ['tp5n']}, 03:46:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:23 INFO - 'talos_options': ['--e10s', 03:46:23 INFO - '--xperf_path', 03:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:23 INFO - 'tests': ['tp5n']}}, 03:46:23 INFO - 'talos.zip': {'path': '', 03:46:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:23 INFO - Running post-action listener: _resource_record_post_action 03:46:23 INFO - ##### 03:46:23 INFO - ##### Running create-virtualenv step. 03:46:23 INFO - ##### 03:46:23 INFO - Running pre-action listener: _resource_record_pre_action 03:46:23 INFO - Running main action method: create_virtualenv 03:46:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:46:23 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 03:46:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:46:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:23 INFO - Using real prefix '/tools/python27' 03:46:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:46:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:27 INFO - Installing pip.................done. 03:46:27 INFO - Return code: 0 03:46:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:27 INFO - 'HOME': '/Users/cltbld', 03:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:27 INFO - 'LOGNAME': 'cltbld', 03:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:27 INFO - 'MOZ_NO_REMOTE': '1', 03:46:27 INFO - 'NO_EM_RESTART': '1', 03:46:27 INFO - 'PAGER': '/bin/cat', 03:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:27 INFO - 'PWD': '/builds/slave/test', 03:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:27 INFO - 'SHELL': '/bin/bash', 03:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:27 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:27 INFO - 'USER': 'cltbld', 03:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:27 INFO - 'XPC_FLAGS': '0x0', 03:46:27 INFO - 'XPC_SERVICE_NAME': '0', 03:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:27 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 03:46:27 INFO - Cleaning up... 03:46:27 INFO - Return code: 0 03:46:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:27 INFO - 'HOME': '/Users/cltbld', 03:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:27 INFO - 'LOGNAME': 'cltbld', 03:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:27 INFO - 'MOZ_NO_REMOTE': '1', 03:46:27 INFO - 'NO_EM_RESTART': '1', 03:46:27 INFO - 'PAGER': '/bin/cat', 03:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:27 INFO - 'PWD': '/builds/slave/test', 03:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:27 INFO - 'SHELL': '/bin/bash', 03:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:27 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:27 INFO - 'USER': 'cltbld', 03:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:27 INFO - 'XPC_FLAGS': '0x0', 03:46:27 INFO - 'XPC_SERVICE_NAME': '0', 03:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:27 INFO - Downloading/unpacking psutil>=0.7.1 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:46:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:30 INFO - Installing collected packages: psutil 03:46:30 INFO - Running setup.py install for psutil 03:46:30 INFO - building 'psutil._psutil_osx' extension 03:46:30 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 03:46:30 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 03:46:31 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 03:46:31 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 03:46:31 INFO - building 'psutil._psutil_posix' extension 03:46:31 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 03:46:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:46:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:46:31 INFO - ^ 03:46:31 INFO - 1 warning generated. 03:46:31 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 03:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:31 INFO - Successfully installed psutil 03:46:31 INFO - Cleaning up... 03:46:31 INFO - Return code: 0 03:46:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:31 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 03:46:31 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 03:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:31 INFO - 'HOME': '/Users/cltbld', 03:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:31 INFO - 'LOGNAME': 'cltbld', 03:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:31 INFO - 'MOZ_NO_REMOTE': '1', 03:46:31 INFO - 'NO_EM_RESTART': '1', 03:46:31 INFO - 'PAGER': '/bin/cat', 03:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:31 INFO - 'PWD': '/builds/slave/test', 03:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:31 INFO - 'SHELL': '/bin/bash', 03:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:31 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:31 INFO - 'USER': 'cltbld', 03:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:31 INFO - 'XPC_FLAGS': '0x0', 03:46:31 INFO - 'XPC_SERVICE_NAME': '0', 03:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:31 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 03:46:31 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 03:46:31 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 03:46:31 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 03:46:31 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 03:46:31 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 03:46:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:34 INFO - Installing collected packages: mozsystemmonitor 03:46:34 INFO - Running setup.py install for mozsystemmonitor 03:46:34 INFO - Successfully installed mozsystemmonitor 03:46:34 INFO - Cleaning up... 03:46:34 INFO - Return code: 0 03:46:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:34 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 03:46:34 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 03:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:34 INFO - 'HOME': '/Users/cltbld', 03:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PAGER': '/bin/cat', 03:46:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test', 03:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:34 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - 'XPC_FLAGS': '0x0', 03:46:34 INFO - 'XPC_SERVICE_NAME': '0', 03:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:36 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 03:46:36 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 03:46:36 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 03:46:36 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 03:46:36 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 03:46:36 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 03:46:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:46:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 INFO - Downloading docopt-0.6.1.tar.gz 03:46:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:37 INFO - Running setup.py install for blobuploader 03:46:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:46:37 INFO - Running setup.py install for requests 03:46:38 INFO - Running setup.py install for docopt 03:46:38 INFO - Successfully installed blobuploader requests docopt 03:46:38 INFO - Cleaning up... 03:46:38 INFO - Return code: 0 03:46:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:38 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')]} 03:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:38 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')]} 03:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:38 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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:38 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 03:46:38 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 03:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:38 INFO - 'HOME': '/Users/cltbld', 03:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:38 INFO - 'LOGNAME': 'cltbld', 03:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:38 INFO - 'MOZ_NO_REMOTE': '1', 03:46:38 INFO - 'NO_EM_RESTART': '1', 03:46:38 INFO - 'PAGER': '/bin/cat', 03:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:38 INFO - 'PWD': '/builds/slave/test', 03:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:38 INFO - 'SHELL': '/bin/bash', 03:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:38 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:38 INFO - 'USER': 'cltbld', 03:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:38 INFO - 'XPC_FLAGS': '0x0', 03:46:38 INFO - 'XPC_SERVICE_NAME': '0', 03:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:38 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jArPsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:38 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-KvAOOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-52ZsRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xU_tzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-9ivGKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-46FH1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-pENW0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-wxZeFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-2f_cQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mLg9SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:39 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6Uzrav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qKlkAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-C75ajF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-5VSrLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6zYG8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-OoPbpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:40 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-sWbIQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:40 INFO - Running setup.py install for manifestparser 03:46:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:46:40 INFO - Running setup.py install for mozcrash 03:46:40 INFO - Running setup.py install for mozdebug 03:46:41 INFO - Running setup.py install for mozdevice 03:46:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Running setup.py install for mozfile 03:46:41 INFO - Running setup.py install for mozhttpd 03:46:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Running setup.py install for mozinfo 03:46:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Running setup.py install for mozInstall 03:46:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:46:41 INFO - Running setup.py install for mozleak 03:46:42 INFO - Running setup.py install for mozlog 03:46:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Running setup.py install for moznetwork 03:46:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Running setup.py install for mozprocess 03:46:42 INFO - Running setup.py install for mozprofile 03:46:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Running setup.py install for mozrunner 03:46:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:46:42 INFO - Running setup.py install for mozscreenshot 03:46:42 INFO - Running setup.py install for moztest 03:46:43 INFO - Running setup.py install for mozversion 03:46:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:46:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:43 INFO - Cleaning up... 03:46:43 INFO - Return code: 0 03:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:43 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 03:46:43 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 03:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:43 INFO - 'HOME': '/Users/cltbld', 03:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:43 INFO - 'LOGNAME': 'cltbld', 03:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:43 INFO - 'MOZ_NO_REMOTE': '1', 03:46:43 INFO - 'NO_EM_RESTART': '1', 03:46:43 INFO - 'PAGER': '/bin/cat', 03:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:43 INFO - 'PWD': '/builds/slave/test', 03:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:43 INFO - 'SHELL': '/bin/bash', 03:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:43 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:43 INFO - 'USER': 'cltbld', 03:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:43 INFO - 'XPC_FLAGS': '0x0', 03:46:43 INFO - 'XPC_SERVICE_NAME': '0', 03:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:43 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-bpC2gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:43 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)) 03:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:43 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-O8xA5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:43 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)) 03:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:43 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-LhKMk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:43 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)) 03:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:43 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-V_FWIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:43 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)) 03:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:43 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-iYQbVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-OWTANo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Ye7rbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-eL7uBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-655q_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-My8dg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-pkbQYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-dAJElf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xgtq1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:44 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)) 03:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:44 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MsODw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:45 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)) 03:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:45 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Rd3lM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:45 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)) 03:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:45 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-O0fkOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:45 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)) 03:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:45 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ipUH56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:45 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)) 03:46:45 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)) 03:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:45 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)) 03:46:45 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)) 03:46:45 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)) 03:46:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:47 INFO - Downloading blessings-1.5.1.tar.gz 03:46:47 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 03:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:47 INFO - Installing collected packages: blessings 03:46:47 INFO - Running setup.py install for blessings 03:46:47 INFO - Successfully installed blessings 03:46:47 INFO - Cleaning up... 03:46:47 INFO - Return code: 0 03:46:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:46:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:48 INFO - Reading from file tmpfile_stdout 03:46:48 INFO - Current package versions: 03:46:48 INFO - blessings == 1.5.1 03:46:48 INFO - blobuploader == 1.2.4 03:46:48 INFO - docopt == 0.6.1 03:46:48 INFO - manifestparser == 1.1 03:46:48 INFO - mozInstall == 1.12 03:46:48 INFO - mozcrash == 0.16 03:46:48 INFO - mozdebug == 0.1 03:46:48 INFO - mozdevice == 0.47 03:46:48 INFO - mozfile == 1.2 03:46:48 INFO - mozhttpd == 0.7 03:46:48 INFO - mozinfo == 0.9 03:46:48 INFO - mozleak == 0.1 03:46:48 INFO - mozlog == 3.0 03:46:48 INFO - moznetwork == 0.27 03:46:48 INFO - mozprocess == 0.22 03:46:48 INFO - mozprofile == 0.27 03:46:48 INFO - mozrunner == 6.11 03:46:48 INFO - mozscreenshot == 0.1 03:46:48 INFO - mozsystemmonitor == 0.0 03:46:48 INFO - moztest == 0.7 03:46:48 INFO - mozversion == 1.4 03:46:48 INFO - psutil == 3.1.1 03:46:48 INFO - requests == 1.2.3 03:46:48 INFO - wsgiref == 0.1.2 03:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:48 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')]} 03:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:48 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')]} 03:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:48 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 0x10b65b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b638228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85724966d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/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.b36ZriOQBM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:46:48 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 03:46:48 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 03:46:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:46:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:48 INFO - 'HOME': '/Users/cltbld', 03:46:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:48 INFO - 'LOGNAME': 'cltbld', 03:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:48 INFO - 'MOZ_NO_REMOTE': '1', 03:46:48 INFO - 'NO_EM_RESTART': '1', 03:46:48 INFO - 'PAGER': '/bin/cat', 03:46:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:48 INFO - 'PWD': '/builds/slave/test', 03:46:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:48 INFO - 'SHELL': '/bin/bash', 03:46:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:46:48 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:46:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:48 INFO - 'USER': 'cltbld', 03:46:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:48 INFO - 'XPC_FLAGS': '0x0', 03:46:48 INFO - 'XPC_SERVICE_NAME': '0', 03:46:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 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)) 03:46:48 INFO - Cleaning up... 03:46:48 INFO - Return code: 0 03:46:48 INFO - Running post-action listener: _resource_record_post_action 03:46:48 INFO - Running post-action listener: _start_resource_monitoring 03:46:48 INFO - Starting resource monitoring. 03:46:48 INFO - ##### 03:46:48 INFO - ##### Running install step. 03:46:48 INFO - ##### 03:46:48 INFO - Running pre-action listener: _resource_record_pre_action 03:46:48 INFO - Running main action method: install 03:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:48 INFO - Reading from file tmpfile_stdout 03:46:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:48 INFO - Reading from file tmpfile_stdout 03:46:48 INFO - Output received: 03:46:48 INFO - Usage: mozinstall [options] installer 03:46:48 INFO - Options: 03:46:48 INFO - -h, --help show this help message and exit 03:46:48 INFO - -d DEST, --destination=DEST 03:46:48 INFO - Directory to install application into. [default: 03:46:48 INFO - "/builds/slave/test"] 03:46:48 INFO - --app=APP Application being installed. [default: firefox] 03:46:48 INFO - mkdir: /builds/slave/test/build/application 03:46:48 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'] 03:46:48 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 03:47:18 INFO - Reading from file tmpfile_stdout 03:47:18 INFO - Output received: 03:47:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:47:18 INFO - Running post-action listener: _resource_record_post_action 03:47:18 INFO - ##### 03:47:18 INFO - ##### Running run-tests step. 03:47:18 INFO - ##### 03:47:18 INFO - Running pre-action listener: _resource_record_pre_action 03:47:18 INFO - Running main action method: run_tests 03:47:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:47:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:47:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:47:18 INFO - 2015-11-19 03:47:18.807 screenresolution[1638:7387] starting screenresolution argv=screenresolution get 03:47:18 INFO - 2015-11-19 03:47:18.810 screenresolution[1638:7387] Display 0: 1600x1200x32@60 03:47:18 INFO - 2015-11-19 03:47:18.815 screenresolution[1639:7389] starting screenresolution argv=screenresolution list 03:47:18 INFO - Available Modes on Display 0 03:47:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:47:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:47:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:47:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:47:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:47:19 INFO - Intel Iris: 03:47:19 INFO - Chipset Model: Intel Iris 03:47:19 INFO - Type: GPU 03:47:19 INFO - Bus: Built-In 03:47:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:47:19 INFO - Vendor: Intel (0x8086) 03:47:19 INFO - Device ID: 0x0a2e 03:47:19 INFO - Revision ID: 0x0009 03:47:19 INFO - Displays: 03:47:19 INFO - Display: 03:47:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:47:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:47:19 INFO - Display Serial Number: 1600x1200 60 03:47:19 INFO - Main Display: Yes 03:47:19 INFO - Mirror: Off 03:47:19 INFO - Online: Yes 03:47:19 INFO - Rotation: Supported 03:47:19 INFO - Return code: 0 03:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:47:19 INFO - Python 2.7.3 03:47:19 INFO - Return code: 0 03:47:19 INFO - grabbing minidump binary from tooltool 03:47:19 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')]} 03:47:19 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 0x10b57f9f0>, '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 0x10b2dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5728c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:47:19 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 03:47:19 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 03:47:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:19 INFO - Return code: 0 03:47:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:47:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:47:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:47:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:47:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:47:19 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/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] in /builds/slave/test/build 03:47:19 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/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost 03:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soxS1IrQJ9/Render', 03:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:19 INFO - 'HOME': '/Users/cltbld', 03:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:19 INFO - 'LOGNAME': 'cltbld', 03:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:19 INFO - 'MOZ_NO_REMOTE': '1', 03:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:19 INFO - 'NO_EM_RESTART': '1', 03:47:19 INFO - 'PAGER': '/bin/cat', 03:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:19 INFO - 'PWD': '/builds/slave/test', 03:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:19 INFO - 'SHELL': '/bin/bash', 03:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b36ZriOQBM/Listeners', 03:47:19 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 03:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:19 INFO - 'USER': 'cltbld', 03:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:19 INFO - 'XPC_FLAGS': '0x0', 03:47:19 INFO - 'XPC_SERVICE_NAME': '0', 03:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:19 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/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] with output_timeout 3600 03:47:19 INFO - mozversion INFO | application_buildid: 20151119005437 03:47:19 INFO - mozversion INFO | application_changeset: 3a6d7dcaaae54d3216f8b93d437a07a55ea44ced 03:47:19 INFO - mozversion INFO | application_display_name: Nightly 03:47:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:19 INFO - mozversion INFO | application_name: Firefox 03:47:19 INFO - mozversion INFO | application_remotingname: firefox 03:47:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:47:19 INFO - mozversion INFO | application_vendor: Mozilla 03:47:19 INFO - mozversion INFO | application_version: 45.0a1 03:47:19 INFO - mozversion INFO | platform_buildid: 20151119005437 03:47:19 INFO - mozversion INFO | platform_changeset: 3a6d7dcaaae54d3216f8b93d437a07a55ea44ced 03:47:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:47:19 INFO - mozversion INFO | platform_version: 45.0a1 03:47:19 INFO - 2015-11-19 03:47:19,363 DEBUG : using testdate: 1447933639 03:47:19 INFO - 2015-11-19 03:47:19,363 DEBUG : actual date: 1447933639 03:47:19 INFO - 2015-11-19 03:47:19,774 INFO : starting webserver on 'localhost:49274' 03:47:19 INFO - 2015-11-19 03:47:19,774 INFO : Starting test suite t-yosemite-r7-0015.e 03:47:19 INFO - 2015-11-19 03:47:19,775 INFO : Starting test dromaeo_css 03:47:19 INFO - 2015-11-19 03:47:19,775 DEBUG : operating with platform_type : mac_ 03:47:19 INFO - 2015-11-19 03:47:19,776 INFO : Initialising browser for dromaeo_css test... 03:47:19 INFO - 2015-11-19 03:47:19,789 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpSwTcqX/profile http://localhost:49274/getInfo.html 03:47:22 INFO - 2015-11-19 03:47:22,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:22 INFO - 2015-11-19 03:47:22,667 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:22 INFO - 2015-11-19 03:47:22,667 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:47:22 INFO - 2015-11-19 03:47:22,667 DEBUG : BROWSER_OUTPUT: __metrics 03:47:23 INFO - 2015-11-19 03:47:23,278 INFO : Browser initialized. 03:47:23 INFO - 2015-11-19 03:47:23,278 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:23 INFO - 2015-11-19 03:47:23,278 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpSwTcqX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:35 INFO - 2015-11-19 03:47:35,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 237326336 03:47:35 INFO - 2015-11-19 03:47:35,140 DEBUG : BROWSER_OUTPUT: 03:48:24 INFO - 2015-11-19 03:48:24,841 DEBUG : BROWSER_OUTPUT: 1447933704838 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] 03:50:34 INFO - 2015-11-19 03:50:34,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 03:50:35 INFO - 2015-11-19 03:50:35,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 252514304 03:50:35 INFO - 2015-11-19 03:50:35,781 DEBUG : BROWSER_OUTPUT: 03:53:37 INFO - 2015-11-19 03:53:37,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 03:53:38 INFO - 2015-11-19 03:53:38,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 263168000 03:53:38 INFO - 2015-11-19 03:53:38,223 DEBUG : BROWSER_OUTPUT: 03:56:39 INFO - 2015-11-19 03:56:39,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 03:56:40 INFO - 2015-11-19 03:56:40,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 263962624 03:56:40 INFO - 2015-11-19 03:56:40,371 DEBUG : BROWSER_OUTPUT: 03:59:41 INFO - 2015-11-19 03:59:41,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 03:59:42 INFO - 2015-11-19 03:59:42,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 266043392 03:59:42 INFO - 2015-11-19 03:59:42,586 DEBUG : BROWSER_OUTPUT: 04:02:45 INFO - 2015-11-19 04:02:45,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 04:02:45 INFO - 2015-11-19 04:02:45,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 269336576 04:02:45 INFO - 2015-11-19 04:02:45,694 DEBUG : BROWSER_OUTPUT: 04:05:47 INFO - 2015-11-19 04:05:47,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 271708160 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:48 INFO - 2015-11-19 04:05:48,097 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3433.158876075361;3483.912902177445;3511.069566564859;3531.8940431787046;3536.575610926689;5621.325440947087;5669.376368599456;5707.058335374663;5713.057345537992;5732.426757324265;4940.45654977953;5436.3476382834015;5561.054620714478;5598;5769.855753606162;5173.5861131109605;5209.531142197202;5294.761735721882;5360.758765855546;5416.729163541827;5299.496547827969;5343.519083282504;5357.491038351351;5365.436629153941;5423.023855705971;4337.284348082562;4555.681102322838;4592.655550833684;5049.48515445365;5302.628815982864;5205;5211;5220.138677118271;5221.138512145491;5252.684838909678;4276.893077673052;5182.734877027448;5186.170212765939;5203.609729270282;5233.607479439057;4591.288350305675;5490.615656904019;5540.833774986717;5616.691081990489;5783.739731712083;6223.844403889893;6266.122742816009;6303.338149494283;6311.400416960381;6324.778632747878;6111.01444231774;6254.519341535042;6308.968455157695;6331.2085989251345;6401.199850018747;5786.768529258825;5881.176635271066;5961.880762384728;5987.880242395127;5991.221141251696;5444.564434845203;5948.72102497965;6322.304546499881;6327;6343.55595108338;5994.220751302303;6242.1261023456755;6250.562460627803;6265.96867015662;6284.025975973731;6157.415045570664;6221.844453888599;6310.116583678288;6328.240611126695;6355.586886852432;6242.313345531988;6265;6311;6311.905321420182;6338.968305158537;6022.488088512438;6207.162033125561;6241.126242326078;6341.23905131378;6346.174997250328;4911.533404326583;4991.201407774739;5009.799608015712;5029.924551131736;5046.44489106198;4475.530069342737;4482.274866427183;4496.100779844044;4536.3422303765765;4540.8637740867825;5636.436356364331;5659.405762394889;5697.544196464273;5819.098039803837;5851.180834683148;5271.20931860224;6284.465820405226;6284.654344011124;6299.6850157491945;6303.180586523723;5120.231965205175;5850.678212698257;5865.853353666193;5873.647581145145;5884.705764711747;4346.695731298779;5080.974595127001;5314.707691077027;5450.809221677301;5460.890782184334;6294.433500984934;6341.8731625368155;6404.423601875854;6406.583572067801;6419.743210271537;6235.812925612239;6300.873982520416;6309.779157729457;6310.305866354789;6314.55798094129;6152.169457123231;6222.595531290452;6305.905411418924;6313.05304204373;6314.62112273265;6248.812535623939;6261.467775239155;6280.937190628035;6290.056491526308;6297.244330680348;6294.3076261612105;6300.21247344082;6309.873802524015;6317.336679648754;6323.873522529431;5925.585209035326;6077.604955677867;6080.939190608037;6111.602745821508;6166.599171053867;6113.780377411107;6125.11336343068;6136.81541228447;6137.989923150331;6142.98993493194;5770.798022069207;6045.879082418239;6075.483583895241;6082.665453400105;6128.264608247039;5954.136650185786;5971.104334349882;6052.75788968454;6074.605150665193;6112.663803490851;4685.5080216578135;5936.5844390892225;5973.223480947449;6109.297430795337;6154.599951003171 04:05:48 INFO - 2015-11-19 04:05:48,099 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.4303046347029;568.6445971267957;577.3072313224129;582.2023827356521;665.3811954881958;40536.79731601341;40684.59315406845;40915.59084409159;40967.79516102415;41235.17529649405;41924.58075419245;42175;42239.577604223945;42538.78730606342;42764;9725.70822875313;9817.901820981806;9875.308728389016;9925.156361709227;9927.354721943051;9667.226621870268;9749.512524373753;9787.510624468749;9788.706338809847;9802.656907008257;9685;9760.560774765117;9777.706668799947;9802.656907008257;9854.950725246365;8223.712170074048;9764.755881102958;9776.755581110458;9791.804163916753;9813.509324533781;9613.711588652352;9676.95161524195;9707.805843883154;9740.172085372751;9759.316847820655;38868.805655971824;39043.60956390428;39256.60743392558;39277;39297.41053884194;3048.8018278811805;3126.6404363498264;3231.6606756290485;3527.876524321662;4104.610062044101;28104.859475702695;28464.715352846415;28758;29070.27324316909;29701.257468563243;2551.655526503917;2614.686237651475;2632.197179860142;2633.841969481837;2704.2968828104636;504136;505247.99999999633;505962;506226;509851.90148098784;58598.7070064647;59948.40051599428;63256.36743632505;63987;69037.3096269041;66021.6698916512;66549.33450665529;66627.66686166538;66779.66610166918;67043.66478167578;13738.725225495435;16164.75752863708;16412;16506.33974641025;16558.337666493204;10537.367757934548;12337.198082124632;12441.377931103409;12536.561220357426;12558.30929298879;19752.9135897527;20060.59878802416;20094.296699615737;20215.595688086156;20295.594088118156;7384.335409813142;7525.887111693329;8664.480131192022;8703.564821758886;8768.430052046597;932.3287233192091;986.1716158426956;1022.4172221833633;1079.2283517285023;1190.6070996571284;26046.479070418864;28141.859290703414;30308.54537181944;30438.69561304403;30651.846740766152;1085.6971634039185;1131.2194585735815;1137.4653912661036;1198.3349241171234;1260.7919693250694;15940.601484962968;16011.839881601034;16088.356465741239;16219;16271.430499932445;497687;500092;502632;505049;505699;58993.705031474565;59074.11388829171;59251.70374148102;59590.40409595849;59596;1453.8110045693993;1457.0310743355762;1465.8241011078526;1467.449706360115;1599.6480774229883;25465.236042918743;27528.862355688092;29880.25299367533;30559.388812224075;30835.383292334478;51187.720306992625;51238.74380628073;51263.71840704012;51421;51662.74168629133;511379;516553;520038;520911;522438;28238.435231294847;28663.713362866103;31068.378632427677;32630.184245394055;33553.83223083869;39635.60364396434;40648.59351406448;42031;42259.366109509;42408.575914240464;31659.84170079135;32473.83763081264;34298.82850585731;35634;35991.460128098624;33254.836080737055;36775.816120920295;36955.63044369522;38031.42952855654;38079;31536.369272614877;34854.65145348514;35027.7740279089;36005.099872502346;36070.8196459016;31792.36415271728;33127.83436082901;33164;33287.50068749019;33401.32993350274;22965.770342296364;25364.74635253624;25785.871070645277;26003.089891853695;26363.86818065974 04:05:48 INFO - 2015-11-19 04:05:48,101 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.5555749746581;360.97112231021504;365.78967093921;365.9030356955407;366.91744357519553;15747.370105195778;18819.623607527858;18973.33593324234;19304.069593040706;19945.301914433;12372.93813530931;12506.124571280014;12552.995760339174;12700.682482937931;19441.027948602583;4596.747178905159;4613.861584152464;4615.953840461586;4622.052479241765;4622.05873533116;4802.351682522867;4881.511848815126;5008.39899212095;5034.647574669774;5034.924476132861;4855.368802055727;4885.145099607572;4936.06214819185;4938.901221975559;4985.526374994388;4971.055499455092;4982.975085124569;4997;5014.52362025607;5020.899582008357;4083.1833633273463;4208.873733787991;4226.85206017791;4346.847860324873;4388.7366757994305;13852.445902163901;13995.580132596038;14106.435742570286;14128.940329475228;14311.856881431157;1894.7063205203215;1907.4277716685078;1908.5896532245633;1920.2319072371024;1994.6808510638227;7922.326602238817;9194.17252447283;10146.949265253626;10303.690889273334;10445.84331235032;1428.585710144057;1559.9860090940865;1601.2314089237116;1662.6009757658196;1667.1497536256475;78173;82737.58631206866;92226;92349.92075435848;95109.0489095107;6857.177138743383;6870.416014638811;6906.067680863019;6932.514723969273;6995.615241161785;7704.8844267336035;7719.768406947801;7822.804429889185;7847.450678452454;7858.921410785819;5738.77044918207;5804.303483581997;5822.398840318946;5871.94128058714;5890.8821823563285;6132.325444201134;6180.351063138306;6184.257889053252;6208.937910620926;6220.657863817533;2901.10065879578;3076.0618011506704;3088.922776930595;3097.845107744649;3114.3304189599344;973.8587904753913;1029.1509504658686;1107.9087099207275;1126.6225814352283;1136.0513970834445;436.97378157310663;468.32794939262266;471.7570451217626;479.7049814364141;498.464151037636;11074.224804263624;11889.88110118905;12141.271523708605;12752.744945101045;12790.488380464678;461.9745913974764;471.56851480894596;490.3625287126721;510.5685695587223;517.9715115668599;5458.781648734006;6416.101745755598;6502.967485162544;6547.705353259114;6574.441172500296;758799;763896;767878;768162;783861;115298;115737;118665.81334186548;119949;122040.1693974591;517.3533083645443;520.4925197932062;524.6589716684109;535.1117145538387;535.8124656370239;11727.237729547553;11819.172657913863;11857.288562686266;11862;12026.338551379407;51702.741486292325;52253.7387313061;52433.47566524286;52834.73582632062;53066;72653.636731816;72747;73318;73342.26657733355;73409.6329518349;6024.132518919149;6232.158658581034;6425.742970281323;6526.086347911391;6543.803685889431;11932.642020739391;12449.875501245235;12478.937605311916;12509.687257818263;12584.685382865135;10502.317349372266;10528.315659482108;10754.73113172177;10777.838332424863;10948.890511095105;10431.426271554834;10617.991290827358;10642.680719578426;10775.6228532001;10824.4046577439;10603.045725884707;10709.020305557953;10882.129429645767;10930;11181.32912025281;6452.290248072803;6496.187976502937;6580.21037475506;6582.243042050225;6689.264180939996;9830.459324737209;10367.533460994122;10892.965168308998;10982.231243812856;11034.448277586249 04:05:48 INFO - 2015-11-19 04:05:48,104 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.2859391788895;1543.344078766524;1817.6001279718457;1828.3600739741091;1842.6130512592351;7308.488405811595;7459.813504662387;7706.422018348619;8076.878846817295;8094.716684916029;7681.539107653531;7856.646450909709;7937.960310198441;7959.681612735498;7959.880601790964;1848.0574906797563;2290.4617414907566;2302.3783578433854;2337.3689103941924;2342.344143639775;2085.8435617328687;2287.816974642033;2353.870537120458;2367.4554852383962;2367.917122900699;1946.5620235447052;2282.3837563857746;2321.9899343785423;2328.75548067453;2336;1995.4313020789077;2015.5162760937417;2123.288698286076;2292.449812045097;2314.1553333033407;1830.560665440298;2361.775631315022;2385.165192182722;2386.988065059681;2397.041183526586;7953.801154971115;8008.919910800876;8036.357091432671;8061.1938806118915;8095.907052547889;4453;4958.950410495885;5075;5075.492450754932;5095.872603184913;3158.8104713717253;3410.215650400397;3418.504316874064;3445.2592692571216;3514.209302906851;1029.1098200056897;1035.4201647077584;1065.7442213868617;1067.7063807452935;1081.4754843900703;10481.423521706303;10506.474676266156;10509;10544.20918431113;10547.525361358681;4519.07358991406;4593.839215627437;4619.076184763061;4678.157931572282;4686.109639168547;9028.774280643036;9062.275017998545;9064.728058158134;9066.22937050345;9073.81852362949;5049.722265275372;5059.696418214919;5082.110630639623;5088.847334579968;5096.235564665256;4565.041341318294;4597.862064138081;4627.884302892455;4633.258678611406;4641.141388843075;3788.924221515554;3797.6202379761803;3807.58116607173;3814.961850381461;3835.290471262825;1273.5860845225338;1274.420138836827;1283.0890068051788;1293.5989843148654;1296.4166125243678;1353.0799056641579;1357.3281225793098;1380.2822532283155;1419.1697856753915;1423.6583220027326;7341.70633174667;7528.284812942762;7542.396608271325;7553.509021913558;7556.508826926342;492.48535280631825;502.50252250271967;502.6632156455184;503.60718639461277;505.84824552634063;5546.972265138648;5782.132680097935;5935.703214839241;5948.791792287249;6012.488938440281;8553.315734741205;9575.89877164135;9620.903790962;9635.22918166545;9728.61085556584;9259.212966897889;9382.765430864283;9502.287328450393;9503.239740820718;9514.143727064597;7504.662290196845;7581.848363032708;7582.241775822374;7600.467967242351;7612.619369031637;7169.928300717134;7275.636218189175;7306.378957788647;7343.37581305595;7375;8275.668973241003;8512.829743405222;8630.439021463584;8671.262942649946;8773.29813614922;8624.913750862412;8868.955655221682;8909.821803564022;8913.688020919497;8915.821683566423;7004.544704594185;7059.894101588583;7086.822829429306;7108.040414543971;7145.214026456982;7241.637918104179;7595.506292090997;7628.54228746277;7639.847203056019;7696.8460630788195;7100.7869763907165;7105.9289407107335;7194.316539928698;7268.600226987566;7285.162206346338;6976.441884649317;6980.546264492792;7031.894521582282;7140.571565706075;7146.3568278855155;7190.7483238086415;7210.459215558749;7228.349448549446;7236.095488063992;7251.854962900607;5679.716014199356;5791.47876691083;6460.612363258219;6565.244996825426;6610;6199.070139478934;6653.9667301663185;6654.600723956578;6685.164354455693;6699.933000669931 04:05:48 INFO - 2015-11-19 04:05:48,105 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.39822735030793;324.8278412441406;331.4630298915757;337.4246909020121;338.33179470545673;6761;7031.402330801875;7047.964760176198;7112.999999999994;7131.572105673663;6975.61634110125;7044.436445084394;7075.823104422379;7081.114860642419;7103.644817759117;4667.18324293249;4692.389989301386;5141;5141.665791723544;5159.509846564571;5076.8730781730565;5127.410347809993;5131.7434128293435;5139.614528910328;5183.429822719498;4738.573528382445;5106.131957567222;5180.948190518103;5181.5854731621375;5182.481751824825;5160.071187186305;5165.7933682652465;5169.767360468788;5180.533751962342;5186.014657215136;4333.198358303724;4434;4440.356148358503;4445.355423463579;4446.333050042487;6770.984352347138;6772.356626120511;6788.660566971632;6790.5246632735725;6806.693698783567;6008.128821320927;6047.7278522466595;6056.788012419544;6073.089036644495;6098.237720284965;7196.424286057103;7449.404047676173;7455.4781165318445;7492.475526713132;7507.924920750777;4437.2234858899565;4827.058723548909;4936.580390666798;4943.406791185081;4954.677945933503;5972.850678733023;6447.677616119222;7929.25556377596;7935.166807485189;7961.681532738684;4828.299896514985;5001.649884508122;5006.07387633289;5008.824691135793;5038.697678139323;5118.59051275897;5119.411267704188;5122.615803814654;5129.435762066169;5147.382314122329;6051.576389652682;6054.182685337423;6054.757809687651;6058.545609079337;6070.817875463743;7272.600006999666;7536.5101268417375;7544.132424771112;7565.583892885834;7586.468947173645;1497.91012539248;1769.0623969296294;1774.5474903899424;1784.643071385728;1791.426743442086;1030.3199888073834;1136.9545218191179;1137.5051852444212;1153.6308381318065;1168.5734706831945;7066.752663656747;7090.716371345192;7091.787246382617;7093.787186384417;7119.430445564446;7836.412269079842;7837.333826624801;7839.25527074927;7855.489393189425;7861.606919654108;6809.795706128824;7032.367086962198;7042.366187043191;7065.89401158983;7115.324044215791;4054.2499637567144;4105.994031462311;4108.753474791522;4136.358864376027;4173.373993900939;8155.10293867674;8190.7952301192945;8194.385421093322;8197.303229225583;8203.466774659628;7899.842003159904;8146.959265203636;8153.510789352539;8157.2250636189465;8187.79530511742;8165.2243036911395;8181.100078991306;8197.262246397733;8218.260356567938;8222.095569487232;7852.921470785219;7905.367570594453;7906.604669766373;7913.920860791319;7919.960400197962;7525.6989720410575;7681.5775132366025;7723.497972631761;7733.651985660771;7782.571958542335;6663.167104111986;8109.75670729879;8121.715739949073;8143.6742530298125;8170.509769413854;4227.957720422756;5004.999000200048;5041.798328066836;5044.899102018013;5050.9747451263975;6822.931770682229;7824.139344671968;7843.6862525498345;7851.882221766792;7863.252990965849;6200.56596038273;7550.2449755026255;7580.696772129053;7589.089309282921;7600.239976002355;5644.604877658525;6681.83295417599;7554.773356799305;7557.8110547234555;7572.507786993828;7364.742234021784;7368.484206105735;7371.631418429164;7376.4467664926415;7388.408927285696;6307.684615769285;7161.033260509765;7484.877268409782;7528.209537998431;7529.924700752922;6591.439727623206;7188.5327453715345;7360.742374016883;7380.889286660597;7427.925720742724 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.6341829085458;790.3203245209121;794.2375319693094;819.3281509162489;841.1252297610481;15093.79249660026;15101.848981510182;15467.69064618707;15548.922255388721;15578.922105389485;14158.646033849132;14256.287185640702;14503.637409064779;14513.782293265609;14615.92692036541;778.7663700889739;953.2278854128143;956.4739393333673;979.3732011512637;982.528386374537;941.7221919533754;945.6690158444524;951.3055469507264;952.0764858087643;954.9856752148723;958.1616085924816;963.720521048895;969.8981606931277;981.0483830684225;982;960.351762560269;965.9758506037335;972.4457059476101;972.8443449048189;973.9172170365528;707.2255879811598;713.3686687281742;715.9642017899084;719.7660760252938;720.661289194078;15151.621209469742;15191.088534687955;15209.391624335014;15218.543443696706;15338.386464541405;10361.844572331345;10409.843852342221;10515.84226236607;10572.52423640938;10908.236423450362;9586.568604412749;9661.758456038655;9945.552450139689;10083.949580252125;10565.577376904914;2651.801114916389;3178.6821317868257;3182.904512864595;3186.314942287396;3208.1017315151794;70238.64880675614;73768.6311568444;74194.62902685507;74420;74460.62769686172;6174.197354343996;7027.754028608974;7201.4238860891;7218.133823941161;7397.927300541392;12436.450527641811;12482.251064936132;12509.562165324352;12520.624381268577;12554.748905021848;5549.38956714761;6489.7404103835315;6653.334666533405;6733.326667333227;6749.021391898147;3969.980150099231;4015.5181378234215;4023.994001499625;4031.4557534732435;4033.193361327746;3155.4793459079456;3171.5559821624993;3172.2069482629345;3180.1572583264992;3188.952165717516;486.04977269438166;486.14195944158587;498.5388515623034;505.2043032224262;512.2188662290038;557.8689008083097;587.6386022596158;596.6092209602717;630.130420020369;641.4002907281706;8250.472183636977;8745.562721863882;8755.605997730117;8863.911360886308;8921.509316987627;578.7169615865455;589.6491587505427;596.7634011548608;630.2216762298558;645.9709313080923;2950.8524573771224;3919.470871432377;4076.7961601919787;4107.794610269475;4240.575942405735;87021.56489217513;97354.0264597345;102544.48727756314;102597.48701256595;103313;84397;84703;87323;88259;89869;77639.835402469;77653;78082;78396;78688;8609.65561377538;8959.104089590988;9010.14403631654;9034.774130646523;9194.770130746785;55072.59419246371;55184.896302074536;55322.44677553334;56656.15015774849;58207.70896145492;76519.8522022159;76837;77399.61300193463;78364.82452763327;79125;8091.312238459562;8116.310113640407;8126.593670316579;8172.7956801080445;8224.588770561328;12143.574974875837;12197.451114699683;12294.139410241198;12706.87293127057;12961.22232666043;11617.709557261136;11866.940665296619;11890.821637675615;11936.28382297065;12183.878161218274;10591.5233814477;11806.82289765637;11842.407879606157;12031.15781895259;12033.338166400932;11291;11306.604268850551;11553;11694.532218711496;11886.34625095628;9189.081091891025;9817.852732209165;9833.360831545926;10052.497375131361;10437.68686939393;9903.702888913343;9983.336234983784;10066.44634545107;10076.695458650678;10113.848292275474 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,317 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: __startTimestamp1447934748093__endTimestamp 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,109 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5727.31 Median:5973.22 stddev:679.57 (11.4%) stddev-sans-first:657.39 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: Values: 3433.2 3483.9 3511.1 3531.9 3536.6 5621.3 5669.4 5707.1 5713.1 5732.4 4940.5 5436.3 5561.1 5598.0 5769.9 5173.6 5209.5 5294.8 5360.8 5416.7 5299.5 5343.5 5357.5 5365.4 5423.0 4337.3 4555.7 4592.7 5049.5 5302.6 5205.0 5211.0 5220.1 5221.1 5252.7 4276.9 5182.7 5186.2 5203.6 5233.6 4591.3 5490.6 5540.8 5616.7 5783.7 6223.8 6266.1 6303.3 6311.4 6324.8 6111.0 6254.5 6309.0 6331.2 6401.2 5786.8 5881.2 5961.9 5987.9 5991.2 5444.6 5948.7 6322.3 6327.0 6343.6 5994.2 6242.1 6250.6 6266.0 6284.0 6157.4 6221.8 6310.1 6328.2 6355.6 6242.3 6265.0 6311.0 6311.9 6339.0 6022.5 6207.2 6241.1 6341.2 6346.2 4911.5 4991.2 5009.8 5029.9 5046.4 4475.5 4482.3 4496.1 4536.3 4540.9 5636.4 5659.4 5697.5 5819.1 5851.2 5271.2 6284.5 6284.7 6299.7 6303.2 5120.2 5850.7 5865.9 5873.6 5884.7 4346.7 5081.0 5314.7 5450.8 5460.9 6294.4 6341.9 6404.4 6406.6 6419.7 6235.8 6300.9 6309.8 6310.3 6314.6 6152.2 6222.6 6305.9 6313.1 6314.6 6248.8 6261.5 6280.9 6290.1 6297.2 6294.3 6300.2 6309.9 6317.3 6323.9 5925.6 6077.6 6080.9 6111.6 6166.6 6113.8 6125.1 6136.8 6138.0 6143.0 5770.8 6045.9 6075.5 6082.7 6128.3 5954.1 5971.1 6052.8 6074.6 6112.7 4685.5 5936.6 5973.2 6109.3 6154.6 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65088.60 Median:39287.21 stddev:135416.56 (344.7%) stddev-sans-first:135709.75 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: Values: 550.4 568.6 577.3 582.2 665.4 40536.8 40684.6 40915.6 40967.8 41235.2 41924.6 42175.0 42239.6 42538.8 42764.0 9725.7 9817.9 9875.3 9925.2 9927.4 9667.2 9749.5 9787.5 9788.7 9802.7 9685.0 9760.6 9777.7 9802.7 9855.0 8223.7 9764.8 9776.8 9791.8 9813.5 9613.7 9677.0 9707.8 9740.2 9759.3 38868.8 39043.6 39256.6 39277.0 39297.4 3048.8 3126.6 3231.7 3527.9 4104.6 28104.9 28464.7 28758.0 29070.3 29701.3 2551.7 2614.7 2632.2 2633.8 2704.3 504136.0 505248.0 505962.0 506226.0 509851.9 58598.7 59948.4 63256.4 63987.0 69037.3 66021.7 66549.3 66627.7 66779.7 67043.7 13738.7 16164.8 16412.0 16506.3 16558.3 10537.4 12337.2 12441.4 12536.6 12558.3 19752.9 20060.6 20094.3 20215.6 20295.6 7384.3 7525.9 8664.5 8703.6 8768.4 932.3 986.2 1022.4 1079.2 1190.6 26046.5 28141.9 30308.5 30438.7 30651.8 1085.7 1131.2 1137.5 1198.3 1260.8 15940.6 16011.8 16088.4 16219.0 16271.4 497687.0 500092.0 502632.0 505049.0 505699.0 58993.7 59074.1 59251.7 59590.4 59596.0 1453.8 1457.0 1465.8 1467.4 1599.6 25465.2 27528.9 29880.3 30559.4 30835.4 51187.7 51238.7 51263.7 51421.0 51662.7 511379.0 516553.0 520038.0 520911.0 522438.0 28238.4 28663.7 31068.4 32630.2 33553.8 39635.6 40648.6 42031.0 42259.4 42408.6 31659.8 32473.8 34298.8 35634.0 35991.5 33254.8 36775.8 36955.6 38031.4 38079.0 31536.4 34854.7 35027.8 36005.1 36070.8 31792.4 33127.8 33164.0 33287.5 33401.3 22965.8 25364.7 25785.9 26003.1 26363.9 04:05:48 INFO - 2015-11-19 04:05:48,110 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,112 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36529.24 Median:4619.00 stddev:126705.30 (2743.1%) stddev-sans-first:127031.60 04:05:48 INFO - 2015-11-19 04:05:48,112 DEBUG : BROWSER_OUTPUT: Values: 340.6 361.0 365.8 365.9 366.9 15747.4 18819.6 18973.3 19304.1 19945.3 12372.9 12506.1 12553.0 12700.7 19441.0 4596.7 4613.9 4616.0 4622.1 4622.1 4802.4 4881.5 5008.4 5034.6 5034.9 4855.4 4885.1 4936.1 4938.9 4985.5 4971.1 4983.0 4997.0 5014.5 5020.9 4083.2 4208.9 4226.9 4346.8 4388.7 13852.4 13995.6 14106.4 14128.9 14311.9 1894.7 1907.4 1908.6 1920.2 1994.7 7922.3 9194.2 10146.9 10303.7 10445.8 1428.6 1560.0 1601.2 1662.6 1667.1 78173.0 82737.6 92226.0 92349.9 95109.0 6857.2 6870.4 6906.1 6932.5 6995.6 7704.9 7719.8 7822.8 7847.5 7858.9 5738.8 5804.3 5822.4 5871.9 5890.9 6132.3 6180.4 6184.3 6208.9 6220.7 2901.1 3076.1 3088.9 3097.8 3114.3 973.9 1029.2 1107.9 1126.6 1136.1 437.0 468.3 471.8 479.7 498.5 11074.2 11889.9 12141.3 12752.7 12790.5 462.0 471.6 490.4 510.6 518.0 5458.8 6416.1 6503.0 6547.7 6574.4 758799.0 763896.0 767878.0 768162.0 783861.0 115298.0 115737.0 118665.8 119949.0 122040.2 517.4 520.5 524.7 535.1 535.8 11727.2 11819.2 11857.3 11862.0 12026.3 51702.7 52253.7 52433.5 52834.7 53066.0 72653.6 72747.0 73318.0 73342.3 73409.6 6024.1 6232.2 6425.7 6526.1 6543.8 11932.6 12449.9 12478.9 12509.7 12584.7 10502.3 10528.3 10754.7 10777.8 10948.9 10431.4 10618.0 10642.7 10775.6 10824.4 10603.0 10709.0 10882.1 10930.0 11181.3 6452.3 6496.2 6580.2 6582.2 6689.3 9830.5 10367.5 10893.0 10982.2 11034.4 04:05:48 INFO - 2015-11-19 04:05:48,112 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,112 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5560.42 Median:5980.64 stddev:2855.65 (47.7%) stddev-sans-first:2847.37 04:05:48 INFO - 2015-11-19 04:05:48,113 DEBUG : BROWSER_OUTPUT: Values: 1503.3 1543.3 1817.6 1828.4 1842.6 7308.5 7459.8 7706.4 8076.9 8094.7 7681.5 7856.6 7938.0 7959.7 7959.9 1848.1 2290.5 2302.4 2337.4 2342.3 2085.8 2287.8 2353.9 2367.5 2367.9 1946.6 2282.4 2322.0 2328.8 2336.0 1995.4 2015.5 2123.3 2292.4 2314.2 1830.6 2361.8 2385.2 2387.0 2397.0 7953.8 8008.9 8036.4 8061.2 8095.9 4453.0 4959.0 5075.0 5075.5 5095.9 3158.8 3410.2 3418.5 3445.3 3514.2 1029.1 1035.4 1065.7 1067.7 1081.5 10481.4 10506.5 10509.0 10544.2 10547.5 4519.1 4593.8 4619.1 4678.2 4686.1 9028.8 9062.3 9064.7 9066.2 9073.8 5049.7 5059.7 5082.1 5088.8 5096.2 4565.0 4597.9 4627.9 4633.3 4641.1 3788.9 3797.6 3807.6 3815.0 3835.3 1273.6 1274.4 1283.1 1293.6 1296.4 1353.1 1357.3 1380.3 1419.2 1423.7 7341.7 7528.3 7542.4 7553.5 7556.5 492.5 502.5 502.7 503.6 505.8 5547.0 5782.1 5935.7 5948.8 6012.5 8553.3 9575.9 9620.9 9635.2 9728.6 9259.2 9382.8 9502.3 9503.2 9514.1 7504.7 7581.8 7582.2 7600.5 7612.6 7169.9 7275.6 7306.4 7343.4 7375.0 8275.7 8512.8 8630.4 8671.3 8773.3 8624.9 8869.0 8909.8 8913.7 8915.8 7004.5 7059.9 7086.8 7108.0 7145.2 7241.6 7595.5 7628.5 7639.8 7696.8 7100.8 7105.9 7194.3 7268.6 7285.2 6976.4 6980.5 7031.9 7140.6 7146.4 7190.7 7210.5 7228.3 7236.1 7251.9 5679.7 5791.5 6460.6 6565.2 6610.0 6199.1 6654.0 6654.6 6685.2 6699.9 04:05:48 INFO - 2015-11-19 04:05:48,113 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,113 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6127.51 Median:6899.27 stddev:1967.49 (28.5%) stddev-sans-first:1924.09 04:05:48 INFO - 2015-11-19 04:05:48,115 DEBUG : BROWSER_OUTPUT: Values: 318.4 324.8 331.5 337.4 338.3 6761.0 7031.4 7048.0 7113.0 7131.6 6975.6 7044.4 7075.8 7081.1 7103.6 4667.2 4692.4 5141.0 5141.7 5159.5 5076.9 5127.4 5131.7 5139.6 5183.4 4738.6 5106.1 5180.9 5181.6 5182.5 5160.1 5165.8 5169.8 5180.5 5186.0 4333.2 4434.0 4440.4 4445.4 4446.3 6771.0 6772.4 6788.7 6790.5 6806.7 6008.1 6047.7 6056.8 6073.1 6098.2 7196.4 7449.4 7455.5 7492.5 7507.9 4437.2 4827.1 4936.6 4943.4 4954.7 5972.9 6447.7 7929.3 7935.2 7961.7 4828.3 5001.6 5006.1 5008.8 5038.7 5118.6 5119.4 5122.6 5129.4 5147.4 6051.6 6054.2 6054.8 6058.5 6070.8 7272.6 7536.5 7544.1 7565.6 7586.5 1497.9 1769.1 1774.5 1784.6 1791.4 1030.3 1137.0 1137.5 1153.6 1168.6 7066.8 7090.7 7091.8 7093.8 7119.4 7836.4 7837.3 7839.3 7855.5 7861.6 6809.8 7032.4 7042.4 7065.9 7115.3 4054.2 4106.0 4108.8 4136.4 4173.4 8155.1 8190.8 8194.4 8197.3 8203.5 7899.8 8147.0 8153.5 8157.2 8187.8 8165.2 8181.1 8197.3 8218.3 8222.1 7852.9 7905.4 7906.6 7913.9 7920.0 7525.7 7681.6 7723.5 7733.7 7782.6 6663.2 8109.8 8121.7 8143.7 8170.5 4228.0 5005.0 5041.8 5044.9 5051.0 6822.9 7824.1 7843.7 7851.9 7863.3 6200.6 7550.2 7580.7 7589.1 7600.2 5644.6 6681.8 7554.8 7557.8 7572.5 7364.7 7368.5 7371.6 7376.4 7388.4 6307.7 7161.0 7484.9 7528.2 7529.9 6591.4 7188.5 7360.7 7380.9 7427.9 04:05:48 INFO - 2015-11-19 04:05:48,115 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,115 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18794.99 Median:596.69 stddev:27685.35 (4639.9%) stddev-sans-first:27729.80 04:05:48 INFO - 2015-11-19 04:05:48,116 DEBUG : BROWSER_OUTPUT: Values: 731.6 790.3 794.2 819.3 841.1 15093.8 15101.8 15467.7 15548.9 15578.9 14158.6 14256.3 14503.6 14513.8 14615.9 778.8 953.2 956.5 979.4 982.5 941.7 945.7 951.3 952.1 955.0 958.2 963.7 969.9 981.0 982.0 960.4 966.0 972.4 972.8 973.9 707.2 713.4 716.0 719.8 720.7 15151.6 15191.1 15209.4 15218.5 15338.4 10361.8 10409.8 10515.8 10572.5 10908.2 9586.6 9661.8 9945.6 10083.9 10565.6 2651.8 3178.7 3182.9 3186.3 3208.1 70238.6 73768.6 74194.6 74420.0 74460.6 6174.2 7027.8 7201.4 7218.1 7397.9 12436.5 12482.3 12509.6 12520.6 12554.7 5549.4 6489.7 6653.3 6733.3 6749.0 3970.0 4015.5 4024.0 4031.5 4033.2 3155.5 3171.6 3172.2 3180.2 3189.0 486.0 486.1 498.5 505.2 512.2 557.9 587.6 596.6 630.1 641.4 8250.5 8745.6 8755.6 8863.9 8921.5 578.7 589.6 596.8 630.2 646.0 2950.9 3919.5 4076.8 4107.8 4240.6 87021.6 97354.0 102544.5 102597.5 103313.0 84397.0 84703.0 87323.0 88259.0 89869.0 77639.8 77653.0 78082.0 78396.0 78688.0 8609.7 8959.1 9010.1 9034.8 9194.8 55072.6 55184.9 55322.4 56656.2 58207.7 76519.9 76837.0 77399.6 78364.8 79125.0 8091.3 8116.3 8126.6 8172.8 8224.6 12143.6 12197.5 12294.1 12706.9 12961.2 11617.7 11866.9 11890.8 11936.3 12183.9 10591.5 11806.8 11842.4 12031.2 12033.3 11291.0 11306.6 11553.0 11694.5 11886.3 9189.1 9817.9 9833.4 10052.5 10437.7 9903.7 9983.3 10066.4 10076.7 10113.8 04:05:48 INFO - 2015-11-19 04:05:48,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:48 INFO - 2015-11-19 04:05:48,116 DEBUG : BROWSER_OUTPUT: 04:05:48 INFO - 2015-11-19 04:05:48,573 INFO : Browser exited with error code: 0 04:05:48 INFO - 2015-11-19 04:05:48,598 INFO : Completed test dromaeo_css (00:18:28) 04:05:48 INFO - 2015-11-19 04:05:48,599 INFO : Starting test kraken 04:05:48 INFO - 2015-11-19 04:05:48,599 DEBUG : operating with platform_type : mac_ 04:05:48 INFO - 2015-11-19 04:05:48,599 INFO : Initialising browser for kraken test... 04:05:48 INFO - 2015-11-19 04:05:48,610 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpZApKLM/profile http://localhost:49274/getInfo.html 04:05:51 INFO - 2015-11-19 04:05:51,314 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:51 INFO - 2015-11-19 04:05:51,314 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:51 INFO - 2015-11-19 04:05:51,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:05:51 INFO - 2015-11-19 04:05:51,314 DEBUG : BROWSER_OUTPUT: __metrics 04:05:51 INFO - 2015-11-19 04:05:51,900 INFO : Browser initialized. 04:05:51 INFO - 2015-11-19 04:05:51,901 INFO : Running cycle 1/1 for kraken test... 04:05:51 INFO - 2015-11-19 04:05:51,901 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpZApKLM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:03 INFO - 2015-11-19 04:06:03,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 237531136 04:06:03 INFO - 2015-11-19 04:06:03,904 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-11-19 04:06:06,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:07 INFO - 2015-11-19 04:06:07,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 249159680 04:06:07 INFO - 2015-11-19 04:06:07,164 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2015-11-19 04:06:09,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 04:06:10 INFO - 2015-11-19 04:06:10,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 258740224 04:06:10 INFO - 2015-11-19 04:06:10,310 DEBUG : BROWSER_OUTPUT: 04:06:13 INFO - 2015-11-19 04:06:13,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 04:06:14 INFO - 2015-11-19 04:06:14,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 261279744 04:06:14 INFO - 2015-11-19 04:06:14,146 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2015-11-19 04:06:16,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 04:06:16 INFO - 2015-11-19 04:06:16,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 263012352 04:06:16 INFO - 2015-11-19 04:06:16,754 DEBUG : BROWSER_OUTPUT: 04:06:18 INFO - 2015-11-19 04:06:18,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:19 INFO - 2015-11-19 04:06:19,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 264192000 04:06:19 INFO - 2015-11-19 04:06:19,296 DEBUG : BROWSER_OUTPUT: 04:06:21 INFO - 2015-11-19 04:06:21,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:22 INFO - 2015-11-19 04:06:22,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 263618560 04:06:22 INFO - 2015-11-19 04:06:22,574 DEBUG : BROWSER_OUTPUT: 04:06:25 INFO - 2015-11-19 04:06:25,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:26 INFO - 2015-11-19 04:06:26,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 262758400 04:06:26 INFO - 2015-11-19 04:06:26,081 DEBUG : BROWSER_OUTPUT: 04:06:29 INFO - 2015-11-19 04:06:29,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 04:06:29 INFO - 2015-11-19 04:06:29,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 263098368 04:06:29 INFO - 2015-11-19 04:06:29,737 DEBUG : BROWSER_OUTPUT: 04:06:31 INFO - 2015-11-19 04:06:31,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:31 INFO - 2015-11-19 04:06:31,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 263843840 04:06:31 INFO - 2015-11-19 04:06:31,903 DEBUG : BROWSER_OUTPUT: 04:06:33 INFO - 2015-11-19 04:06:33,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:34 INFO - 2015-11-19 04:06:34,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 264073216 04:06:34 INFO - 2015-11-19 04:06:34,281 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2015-11-19 04:06:36,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:37 INFO - 2015-11-19 04:06:37,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 264142848 04:06:37 INFO - 2015-11-19 04:06:37,048 DEBUG : BROWSER_OUTPUT: 04:06:39 INFO - 2015-11-19 04:06:39,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:40 INFO - 2015-11-19 04:06:40,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 263663616 04:06:40 INFO - 2015-11-19 04:06:40,159 DEBUG : BROWSER_OUTPUT: 04:06:42 INFO - 2015-11-19 04:06:42,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:43 INFO - 2015-11-19 04:06:43,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 264888320 04:06:43 INFO - 2015-11-19 04:06:43,174 DEBUG : BROWSER_OUTPUT: 04:06:44 INFO - 2015-11-19 04:06:44,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 04:06:45 INFO - 2015-11-19 04:06:45,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 264040448 04:06:45 INFO - 2015-11-19 04:06:45,194 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: |0;ai-astar;149;152;134;115;114;127;114;115;116;116 04:06:45 INFO - 2015-11-19 04:06:45,195 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;122;144;155;123;144;155;121;156;127 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |2;audio-dft;196;196;192;193;201;204;208;216;239;195 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |3;audio-fft;56;62;62;65;107;67;82;86;86;125 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;80;78;107;76;77;79;111;75;79;113 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;87;86;90;128;88;87;87;86;88 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;96;94;95;96;94;128;92;149;150 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;138;90;81;144;148;92;119;113;91;111 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;67;91;74;59;61;59;68;60;57 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;65;65;63;67;65;67;67;68;70 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;93;108;108;107;82;88;84;85;86 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;133;124;128;132;121;134;138;116;123 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;138;139;138;141;138;143;142;134;129 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;86;89;91;93;91;66;68;65;63 04:06:45 INFO - 2015-11-19 04:06:45,196 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:45 INFO - 2015-11-19 04:06:45,197 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:45 INFO - 2015-11-19 04:06:45,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,817 04:06:45 INFO - 2015-11-19 04:06:45,197 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:45 INFO - 2015-11-19 04:06:45,197 DEBUG : BROWSER_OUTPUT: __startTimestamp1447934805194__endTimestamp 04:06:45 INFO - 2015-11-19 04:06:45,197 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,200 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:45 INFO - 2015-11-19 04:06:45,200 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:45 INFO - 2015-11-19 04:06:45,200 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,200 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.20 Median:121.50 stddev:14.88 (12.2%) stddev-sans-first:13.06 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: Values: 149.0 152.0 134.0 115.0 114.0 127.0 114.0 115.0 116.0 116.0 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.10 Median:144.00 stddev:14.49 (10.1%) stddev-sans-first:15.26 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: Values: 144.0 122.0 144.0 155.0 123.0 144.0 155.0 121.0 156.0 127.0 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.00 Median:202.50 stddev:14.41 (7.1%) stddev-sans-first:14.99 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: Values: 196.0 196.0 192.0 193.0 201.0 204.0 208.0 216.0 239.0 195.0 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:66.00 stddev:22.23 (33.7%) stddev-sans-first:21.85 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: Values: 56.0 62.0 62.0 65.0 107.0 67.0 82.0 86.0 86.0 125.0 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.50 Median:77.50 stddev:15.89 (20.5%) stddev-sans-first:16.62 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: Values: 80.0 78.0 107.0 76.0 77.0 79.0 111.0 75.0 79.0 113.0 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,201 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:87.00 stddev:12.91 (14.8%) stddev-sans-first:13.60 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: Values: 87.0 87.0 86.0 90.0 128.0 88.0 87.0 87.0 86.0 88.0 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:108.80 Median:94.00 stddev:23.90 (25.4%) stddev-sans-first:24.74 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 94.0 95.0 96.0 94.0 128.0 92.0 149.0 150.0 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:112.70 Median:114.50 stddev:24.33 (21.3%) stddev-sans-first:24.02 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: Values: 138.0 90.0 81.0 144.0 148.0 92.0 119.0 113.0 91.0 111.0 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.00 stddev:10.69 (16.7%) stddev-sans-first:10.80 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: Values: 56.0 67.0 91.0 74.0 59.0 61.0 59.0 68.0 60.0 57.0 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:67.00 stddev:2.38 (3.5%) stddev-sans-first:2.06 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: Values: 62.0 65.0 65.0 63.0 67.0 65.0 67.0 67.0 68.0 70.0 04:06:45 INFO - 2015-11-19 04:06:45,202 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:85.50 stddev:10.72 (12.5%) stddev-sans-first:11.09 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: Values: 86.0 93.0 108.0 108.0 107.0 82.0 88.0 84.0 85.0 86.0 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:130.00 stddev:6.98 (5.4%) stddev-sans-first:7.16 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: Values: 122.0 133.0 124.0 128.0 132.0 121.0 134.0 138.0 116.0 123.0 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:138.50 stddev:4.16 (3.0%) stddev-sans-first:4.30 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: Values: 135.0 138.0 139.0 138.0 141.0 138.0 143.0 142.0 134.0 129.0 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:87.50 stddev:12.85 (14.7%) stddev-sans-first:13.11 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: Values: 68.0 86.0 89.0 91.0 93.0 91.0 66.0 68.0 65.0 63.0 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:45 INFO - 2015-11-19 04:06:45,203 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-11-19 04:06:45,795 INFO : Browser exited with error code: 0 04:06:45 INFO - 2015-11-19 04:06:45,839 INFO : Completed test kraken (00:00:57) 04:06:45 INFO - 2015-11-19 04:06:45,839 INFO : Starting test v8_7 04:06:45 INFO - 2015-11-19 04:06:45,839 DEBUG : operating with platform_type : mac_ 04:06:45 INFO - 2015-11-19 04:06:45,839 INFO : Initialising browser for v8_7 test... 04:06:45 INFO - 2015-11-19 04:06:45,851 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpcZtdHT/profile http://localhost:49274/getInfo.html 04:06:48 INFO - 2015-11-19 04:06:48,582 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:48 INFO - 2015-11-19 04:06:48,582 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:48 INFO - 2015-11-19 04:06:48,582 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:06:48 INFO - 2015-11-19 04:06:48,582 DEBUG : BROWSER_OUTPUT: __metrics 04:06:49 INFO - 2015-11-19 04:06:49,150 INFO : Browser initialized. 04:06:49 INFO - 2015-11-19 04:06:49,150 INFO : Running cycle 1/1 for v8_7 test... 04:06:49 INFO - 2015-11-19 04:06:49,151 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpcZtdHT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:01 INFO - 2015-11-19 04:07:01,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 236953600 04:07:01 INFO - 2015-11-19 04:07:01,006 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 247373824 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:22 INFO - 2015-11-19 04:07:22,636 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |0;Richards;632.1112515802781 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.0598397989634 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.5270768358378 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4713.615023474178 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |4;RayTrace;951.4747859181732 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |5;Earley;740.3846153846154 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |8;Splay;657.030223390276 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1447934842630__endTimestamp 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,637 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:632.11 Median:632.11 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: Values: 632.1 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.06 Median:157.06 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: Values: 157.1 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.53 Median:283.53 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: Values: 283.5 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4713.62 Median:4713.62 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: Values: 4713.6 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,638 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: Values: 951.5 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.38 Median:740.38 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: Values: 740.4 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: Values: 12072.3 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: Values: 27216.2 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:657.03 Median:657.03 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: Values: 657.0 04:07:22 INFO - 2015-11-19 04:07:22,639 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-19 04:07:22,640 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 04:07:22 INFO - 2015-11-19 04:07:22,640 DEBUG : BROWSER_OUTPUT: Values: 4509.0 04:07:22 INFO - 2015-11-19 04:07:22,640 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:22 INFO - 2015-11-19 04:07:22,640 DEBUG : BROWSER_OUTPUT: 04:07:23 INFO - 2015-11-19 04:07:23,247 INFO : Browser exited with error code: 0 04:07:23 INFO - 2015-11-19 04:07:23,264 INFO : Completed test v8_7 (00:00:37) 04:07:23 INFO - 2015-11-19 04:07:23,276 INFO : Completed test suite (00:20:03) 04:07:23 INFO - 2015-11-19 04:07:23,276 DEBUG : Working with test: dromaeo_css 04:07:23 INFO - 2015-11-19 04:07:23,277 DEBUG : Generating results file: dromaeo_css 04:07:23 INFO - 2015-11-19 04:07:23,278 DEBUG : Working with test: kraken 04:07:23 INFO - 2015-11-19 04:07:23,278 DEBUG : Generating results file: kraken 04:07:23 INFO - 2015-11-19 04:07:23,278 INFO : javascript benchmark 04:07:23 INFO - 2015-11-19 04:07:23,278 DEBUG : Working with test: v8_7 04:07:23 INFO - 2015-11-19 04:07:23,278 DEBUG : Generating results file: v8_7 04:07:23 INFO - 2015-11-19 04:07:23,279 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:23 INFO - 2015-11-19 04:07:23,813 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:07:23 INFO - 2015-11-19 04:07:23,813 DEBUG : process_Request line: dromaeo_css 7186.50 graph.html#tests=[[72,64,61]] 04:07:23 INFO - 2015-11-19 04:07:23,813 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:23 INFO - 2015-11-19 04:07:23,838 DEBUG : process_Request line: kraken 1515.10 graph.html#tests=[[232,64,61]] 04:07:23 INFO - 2015-11-19 04:07:23,838 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:23 INFO - 2015-11-19 04:07:23,868 DEBUG : process_Request line: v8_7 19226.84 graph.html#tests=[[230,64,61]] 04:07:23 INFO - 2015-11-19 04:07:23,869 INFO : javascript benchmark 04:07:23 INFO - 2015-11-19 04:07:23,871 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3433.158876075361, 3483.912902177445, 3511.069566564859, 3531.8940431787046, 3536.575610926689, 5621.325440947087, 5669.376368599456, 5707.058335374663, 5713.057345537992, 5732.426757324265, 4940.45654977953, 5436.3476382834015, 5561.054620714478, 5598.0, 5769.855753606162, 5173.5861131109605, 5209.531142197202, 5294.761735721882, 5360.758765855546, 5416.729163541827, 5299.496547827969, 5343.519083282504, 5357.491038351351, 5365.436629153941, 5423.023855705971, 4337.284348082562, 4555.681102322838, 4592.655550833684, 5049.48515445365, 5302.628815982864, 5205.0, 5211.0, 5220.138677118271, 5221.138512145491, 5252.684838909678, 4276.893077673052, 5182.734877027448, 5186.170212765939, 5203.609729270282, 5233.607479439057, 4591.288350305675, 5490.615656904019, 5540.833774986717, 5616.691081990489, 5783.739731712083, 6223.844403889893, 6266.122742816009, 6303.338149494283, 6311.400416960381, 6324.778632747878, 6111.01444231774, 6254.519341535042, 6308.968455157695, 6331.2085989251345, 6401.199850018747, 5786.768529258825, 5881.176635271066, 5961.880762384728, 5987.880242395127, 5991.221141251696, 5444.564434845203, 5948.72102497965, 6322.304546499881, 6327.0, 6343.55595108338, 5994.220751302303, 6242.1261023456755, 6250.562460627803, 6265.96867015662, 6284.025975973731, 6157.415045570664, 6221.844453888599, 6310.116583678288, 6328.240611126695, 6355.586886852432, 6242.313345531988, 6265.0, 6311.0, 6311.905321420182, 6338.968305158537, 6022.488088512438, 6207.162033125561, 6241.126242326078, 6341.23905131378, 6346.174997250328, 4911.533404326583, 4991.201407774739, 5009.799608015712, 5029.924551131736, 5046.44489106198, 4475.530069342737, 4482.274866427183, 4496.100779844044, 4536.3422303765765, 4540.8637740867825, 5636.436356364331, 5659.405762394889, 5697.544196464273, 5819.098039803837, 5851.180834683148, 5271.20931860224, 6284.465820405226, 6284.654344011124, 6299.6850157491945, 6303.180586523723, 5120.231965205175, 5850.678212698257, 5865.853353666193, 5873.647581145145, 5884.705764711747, 4346.695731298779, 5080.974595127001, 5314.707691077027, 5450.809221677301, 5460.890782184334, 6294.433500984934, 6341.8731625368155, 6404.423601875854, 6406.583572067801, 6419.743210271537, 6235.812925612239, 6300.873982520416, 6309.779157729457, 6310.305866354789, 6314.55798094129, 6152.169457123231, 6222.595531290452, 6305.905411418924, 6313.05304204373, 6314.62112273265, 6248.812535623939, 6261.467775239155, 6280.937190628035, 6290.056491526308, 6297.244330680348, 6294.3076261612105, 6300.21247344082, 6309.873802524015, 6317.336679648754, 6323.873522529431, 5925.585209035326, 6077.604955677867, 6080.939190608037, 6111.602745821508, 6166.599171053867, 6113.780377411107, 6125.11336343068, 6136.81541228447, 6137.989923150331, 6142.98993493194, 5770.798022069207, 6045.879082418239, 6075.483583895241, 6082.665453400105, 6128.264608247039, 5954.136650185786, 5971.104334349882, 6052.75788968454, 6074.605150665193, 6112.663803490851, 4685.5080216578135, 5936.5844390892225, 5973.223480947449, 6109.297430795337, 6154.599951003171], "unit": "ms", "name": "dojo.html", "value": 5685.657371209115}, {"lowerIsBetter": false, "replicates": [550.4303046347029, 568.6445971267957, 577.3072313224129, 582.2023827356521, 665.3811954881958, 40536.79731601341, 40684.59315406845, 40915.59084409159, 40967.79516102415, 41235.17529649405, 41924.58075419245, 42175.0, 42239.577604223945, 42538.78730606342, 42764.0, 9725.70822875313, 9817.901820981806, 9875.308728389016, 9925.156361709227, 9927.354721943051, 9667.226621870268, 9749.512524373753, 9787.510624468749, 9788.706338809847, 9802.656907008257, 9685.0, 9760.560774765117, 9777.706668799947, 9802.656907008257, 9854.950725246365, 8223.712170074048, 9764.755881102958, 9776.755581110458, 9791.804163916753, 9813.509324533781, 9613.711588652352, 9676.95161524195, 9707.805843883154, 9740.172085372751, 9759.316847820655, 38868.805655971824, 39043.60956390428, 39256.60743392558, 39277.0, 39297.41053884194, 3048.8018278811805, 3126.6404363498264, 3231.6606756290485, 3527.876524321662, 4104.610062044101, 28104.859475702695, 28464.715352846415, 28758.0, 29070.27324316909, 29701.257468563243, 2551.655526503917, 2614.686237651475, 2632.197179860142, 2633.841969481837, 2704.2968828104636, 504136.0, 505247.99999999633, 505962.0, 506226.0, 509851.90148098784, 58598.7070064647, 59948.40051599428, 63256.36743632505, 63987.0, 69037.3096269041, 66021.6698916512, 66549.33450665529, 66627.66686166538, 66779.66610166918, 67043.66478167578, 13738.725225495435, 16164.75752863708, 16412.0, 16506.33974641025, 16558.337666493204, 10537.367757934548, 12337.198082124632, 12441.377931103409, 12536.561220357426, 12558.30929298879, 19752.9135897527, 20060.59878802416, 20094.296699615737, 20215.595688086156, 20295.594088118156, 7384.335409813142, 7525.887111693329, 8664.480131192022, 8703.564821758886, 8768.430052046597, 932.3287233192091, 986.1716158426956, 1022.4172221833633, 1079.2283517285023, 1190.6070996571284, 26046.479070418864, 28141.859290703414, 30308.54537181944, 30438.69561304403, 30651.846740766152, 1085.6971634039185, 1131.2194585735815, 1137.4653912661036, 1198.3349241171234, 1260.7919693250694, 15940.601484962968, 16011.839881601034, 16088.356465741239, 16219.0, 16271.430499932445, 497687.0, 500092.0, 502632.0, 505049.0, 505699.0, 58993.705031474565, 59074.11388829171, 59251.70374148102, 59590.40409595849, 59596.0, 1453.8110045693993, 1457.0310743355762, 1465.8241011078526, 1467.449706360115, 1599.6480774229883, 25465.236042918743, 27528.862355688092, 29880.25299367533, 30559.388812224075, 30835.383292334478, 51187.720306992625, 51238.74380628073, 51263.71840704012, 51421.0, 51662.74168629133, 511379.0, 516553.0, 520038.0, 520911.0, 522438.0, 28238.435231294847, 28663.713362866103, 31068.378632427677, 32630.184245394055, 33553.83223083869, 39635.60364396434, 40648.59351406448, 42031.0, 42259.366109509, 42408.575914240464, 31659.84170079135, 32473.83763081264, 34298.82850585731, 35634.0, 35991.460128098624, 33254.836080737055, 36775.816120920295, 36955.63044369522, 38031.42952855654, 38079.0, 31536.369272614877, 34854.65145348514, 35027.7740279089, 36005.099872502346, 36070.8196459016, 31792.36415271728, 33127.83436082901, 33164.0, 33287.50068749019, 33401.32993350274, 22965.770342296364, 25364.74635253624, 25785.871070645277, 26003.089891853695, 26363.86818065974], "unit": "ms", "name": "ext.html", "value": 19859.80490773209}, {"lowerIsBetter": false, "replicates": [340.5555749746581, 360.97112231021504, 365.78967093921, 365.9030356955407, 366.91744357519553, 15747.370105195778, 18819.623607527858, 18973.33593324234, 19304.069593040706, 19945.301914433, 12372.93813530931, 12506.124571280014, 12552.995760339174, 12700.682482937931, 19441.027948602583, 4596.747178905159, 4613.861584152464, 4615.953840461586, 4622.052479241765, 4622.05873533116, 4802.351682522867, 4881.511848815126, 5008.39899212095, 5034.647574669774, 5034.924476132861, 4855.368802055727, 4885.145099607572, 4936.06214819185, 4938.901221975559, 4985.526374994388, 4971.055499455092, 4982.975085124569, 4997.0, 5014.52362025607, 5020.899582008357, 4083.1833633273463, 4208.873733787991, 4226.85206017791, 4346.847860324873, 4388.7366757994305, 13852.445902163901, 13995.580132596038, 14106.435742570286, 14128.940329475228, 14311.856881431157, 1894.7063205203215, 1907.4277716685078, 1908.5896532245633, 1920.2319072371024, 1994.6808510638227, 7922.326602238817, 9194.17252447283, 10146.949265253626, 10303.690889273334, 10445.84331235032, 1428.585710144057, 1559.9860090940865, 1601.2314089237116, 1662.6009757658196, 1667.1497536256475, 78173.0, 82737.58631206866, 92226.0, 92349.92075435848, 95109.0489095107, 6857.177138743383, 6870.416014638811, 6906.067680863019, 6932.514723969273, 6995.615241161785, 7704.8844267336035, 7719.768406947801, 7822.804429889185, 7847.450678452454, 7858.921410785819, 5738.77044918207, 5804.303483581997, 5822.398840318946, 5871.94128058714, 5890.8821823563285, 6132.325444201134, 6180.351063138306, 6184.257889053252, 6208.937910620926, 6220.657863817533, 2901.10065879578, 3076.0618011506704, 3088.922776930595, 3097.845107744649, 3114.3304189599344, 973.8587904753913, 1029.1509504658686, 1107.9087099207275, 1126.6225814352283, 1136.0513970834445, 436.97378157310663, 468.32794939262266, 471.7570451217626, 479.7049814364141, 498.464151037636, 11074.224804263624, 11889.88110118905, 12141.271523708605, 12752.744945101045, 12790.488380464678, 461.9745913974764, 471.56851480894596, 490.3625287126721, 510.5685695587223, 517.9715115668599, 5458.781648734006, 6416.101745755598, 6502.967485162544, 6547.705353259114, 6574.441172500296, 758799.0, 763896.0, 767878.0, 768162.0, 783861.0, 115298.0, 115737.0, 118665.81334186548, 119949.0, 122040.1693974591, 517.3533083645443, 520.4925197932062, 524.6589716684109, 535.1117145538387, 535.8124656370239, 11727.237729547553, 11819.172657913863, 11857.288562686266, 11862.0, 12026.338551379407, 51702.741486292325, 52253.7387313061, 52433.47566524286, 52834.73582632062, 53066.0, 72653.636731816, 72747.0, 73318.0, 73342.26657733355, 73409.6329518349, 6024.132518919149, 6232.158658581034, 6425.742970281323, 6526.086347911391, 6543.803685889431, 11932.642020739391, 12449.875501245235, 12478.937605311916, 12509.687257818263, 12584.685382865135, 10502.317349372266, 10528.315659482108, 10754.73113172177, 10777.838332424863, 10948.890511095105, 10431.426271554834, 10617.991290827358, 10642.680719578426, 10775.6228532001, 10824.4046577439, 10603.045725884707, 10709.020305557953, 10882.129429645767, 10930.0, 11181.32912025281, 6452.290248072803, 6496.187976502937, 6580.21037475506, 6582.243042050225, 6689.264180939996, 9830.459324737209, 10367.533460994122, 10892.965168308998, 10982.231243812856, 11034.448277586249], "unit": "ms", "name": "jquery.html", "value": 7324.525134753315}, {"lowerIsBetter": false, "replicates": [1503.2859391788895, 1543.344078766524, 1817.6001279718457, 1828.3600739741091, 1842.6130512592351, 7308.488405811595, 7459.813504662387, 7706.422018348619, 8076.878846817295, 8094.716684916029, 7681.539107653531, 7856.646450909709, 7937.960310198441, 7959.681612735498, 7959.880601790964, 1848.0574906797563, 2290.4617414907566, 2302.3783578433854, 2337.3689103941924, 2342.344143639775, 2085.8435617328687, 2287.816974642033, 2353.870537120458, 2367.4554852383962, 2367.917122900699, 1946.5620235447052, 2282.3837563857746, 2321.9899343785423, 2328.75548067453, 2336.0, 1995.4313020789077, 2015.5162760937417, 2123.288698286076, 2292.449812045097, 2314.1553333033407, 1830.560665440298, 2361.775631315022, 2385.165192182722, 2386.988065059681, 2397.041183526586, 7953.801154971115, 8008.919910800876, 8036.357091432671, 8061.1938806118915, 8095.907052547889, 4453.0, 4958.950410495885, 5075.0, 5075.492450754932, 5095.872603184913, 3158.8104713717253, 3410.215650400397, 3418.504316874064, 3445.2592692571216, 3514.209302906851, 1029.1098200056897, 1035.4201647077584, 1065.7442213868617, 1067.7063807452935, 1081.4754843900703, 10481.423521706303, 10506.474676266156, 10509.0, 10544.20918431113, 10547.525361358681, 4519.07358991406, 4593.839215627437, 4619.076184763061, 4678.157931572282, 4686.109639168547, 9028.774280643036, 9062.275017998545, 9064.728058158134, 9066.22937050345, 9073.81852362949, 5049.722265275372, 5059.696418214919, 5082.110630639623, 5088.847334579968, 5096.235564665256, 4565.041341318294, 4597.862064138081, 4627.884302892455, 4633.258678611406, 4641.141388843075, 3788.924221515554, 3797.6202379761803, 3807.58116607173, 3814.961850381461, 3835.290471262825, 1273.5860845225338, 1274.420138836827, 1283.0890068051788, 1293.5989843148654, 1296.4166125243678, 1353.0799056641579, 1357.3281225793098, 1380.2822532283155, 1419.1697856753915, 1423.6583220027326, 7341.70633174667, 7528.284812942762, 7542.396608271325, 7553.509021913558, 7556.508826926342, 492.48535280631825, 502.50252250271967, 502.6632156455184, 503.60718639461277, 505.84824552634063, 5546.972265138648, 5782.132680097935, 5935.703214839241, 5948.791792287249, 6012.488938440281, 8553.315734741205, 9575.89877164135, 9620.903790962, 9635.22918166545, 9728.61085556584, 9259.212966897889, 9382.765430864283, 9502.287328450393, 9503.239740820718, 9514.143727064597, 7504.662290196845, 7581.848363032708, 7582.241775822374, 7600.467967242351, 7612.619369031637, 7169.928300717134, 7275.636218189175, 7306.378957788647, 7343.37581305595, 7375.0, 8275.668973241003, 8512.829743405222, 8630.439021463584, 8671.262942649946, 8773.29813614922, 8624.913750862412, 8868.955655221682, 8909.821803564022, 8913.688020919497, 8915.821683566423, 7004.544704594185, 7059.894101588583, 7086.822829429306, 7108.040414543971, 7145.214026456982, 7241.637918104179, 7595.506292090997, 7628.54228746277, 7639.847203056019, 7696.8460630788195, 7100.7869763907165, 7105.9289407107335, 7194.316539928698, 7268.600226987566, 7285.162206346338, 6976.441884649317, 6980.546264492792, 7031.894521582282, 7140.571565706075, 7146.3568278855155, 7190.7483238086415, 7210.459215558749, 7228.349448549446, 7236.095488063992, 7251.854962900607, 5679.716014199356, 5791.47876691083, 6460.612363258219, 6565.244996825426, 6610.0, 6199.070139478934, 6653.9667301663185, 6654.600723956578, 6685.164354455693, 6699.933000669931], "unit": "ms", "name": "mootools.html", "value": 4518.3521961813}, {"lowerIsBetter": false, "replicates": [318.39822735030793, 324.8278412441406, 331.4630298915757, 337.4246909020121, 338.33179470545673, 6761.0, 7031.402330801875, 7047.964760176198, 7112.999999999994, 7131.572105673663, 6975.61634110125, 7044.436445084394, 7075.823104422379, 7081.114860642419, 7103.644817759117, 4667.18324293249, 4692.389989301386, 5141.0, 5141.665791723544, 5159.509846564571, 5076.8730781730565, 5127.410347809993, 5131.7434128293435, 5139.614528910328, 5183.429822719498, 4738.573528382445, 5106.131957567222, 5180.948190518103, 5181.5854731621375, 5182.481751824825, 5160.071187186305, 5165.7933682652465, 5169.767360468788, 5180.533751962342, 5186.014657215136, 4333.198358303724, 4434.0, 4440.356148358503, 4445.355423463579, 4446.333050042487, 6770.984352347138, 6772.356626120511, 6788.660566971632, 6790.5246632735725, 6806.693698783567, 6008.128821320927, 6047.7278522466595, 6056.788012419544, 6073.089036644495, 6098.237720284965, 7196.424286057103, 7449.404047676173, 7455.4781165318445, 7492.475526713132, 7507.924920750777, 4437.2234858899565, 4827.058723548909, 4936.580390666798, 4943.406791185081, 4954.677945933503, 5972.850678733023, 6447.677616119222, 7929.25556377596, 7935.166807485189, 7961.681532738684, 4828.299896514985, 5001.649884508122, 5006.07387633289, 5008.824691135793, 5038.697678139323, 5118.59051275897, 5119.411267704188, 5122.615803814654, 5129.435762066169, 5147.382314122329, 6051.576389652682, 6054.182685337423, 6054.757809687651, 6058.545609079337, 6070.817875463743, 7272.600006999666, 7536.5101268417375, 7544.132424771112, 7565.583892885834, 7586.468947173645, 1497.91012539248, 1769.0623969296294, 1774.5474903899424, 1784.643071385728, 1791.426743442086, 1030.3199888073834, 1136.9545218191179, 1137.5051852444212, 1153.6308381318065, 1168.5734706831945, 7066.752663656747, 7090.716371345192, 7091.787246382617, 7093.787186384417, 7119.430445564446, 7836.412269079842, 7837.333826624801, 7839.25527074927, 7855.489393189425, 7861.606919654108, 6809.795706128824, 7032.367086962198, 7042.366187043191, 7065.89401158983, 7115.324044215791, 4054.2499637567144, 4105.994031462311, 4108.753474791522, 4136.358864376027, 4173.373993900939, 8155.10293867674, 8190.7952301192945, 8194.385421093322, 8197.303229225583, 8203.466774659628, 7899.842003159904, 8146.959265203636, 8153.510789352539, 8157.2250636189465, 8187.79530511742, 8165.2243036911395, 8181.100078991306, 8197.262246397733, 8218.260356567938, 8222.095569487232, 7852.921470785219, 7905.367570594453, 7906.604669766373, 7913.920860791319, 7919.960400197962, 7525.6989720410575, 7681.5775132366025, 7723.497972631761, 7733.651985660771, 7782.571958542335, 6663.167104111986, 8109.75670729879, 8121.715739949073, 8143.6742530298125, 8170.509769413854, 4227.957720422756, 5004.999000200048, 5041.798328066836, 5044.899102018013, 5050.9747451263975, 6822.931770682229, 7824.139344671968, 7843.6862525498345, 7851.882221766792, 7863.252990965849, 6200.56596038273, 7550.2449755026255, 7580.696772129053, 7589.089309282921, 7600.239976002355, 5644.604877658525, 6681.83295417599, 7554.773356799305, 7557.8110547234555, 7572.507786993828, 7364.742234021784, 7368.484206105735, 7371.631418429164, 7376.4467664926415, 7388.408927285696, 6307.684615769285, 7161.033260509765, 7484.877268409782, 7528.209537998431, 7529.924700752922, 6591.439727623206, 7188.5327453715345, 7360.742374016883, 7380.889286660597, 7427.925720742724], "unit": "ms", "name": "prototype.html", "value": 5462.534883404326}, {"lowerIsBetter": false, "replicates": [731.6341829085458, 790.3203245209121, 794.2375319693094, 819.3281509162489, 841.1252297610481, 15093.79249660026, 15101.848981510182, 15467.69064618707, 15548.922255388721, 15578.922105389485, 14158.646033849132, 14256.287185640702, 14503.637409064779, 14513.782293265609, 14615.92692036541, 778.7663700889739, 953.2278854128143, 956.4739393333673, 979.3732011512637, 982.528386374537, 941.7221919533754, 945.6690158444524, 951.3055469507264, 952.0764858087643, 954.9856752148723, 958.1616085924816, 963.720521048895, 969.8981606931277, 981.0483830684225, 982.0, 960.351762560269, 965.9758506037335, 972.4457059476101, 972.8443449048189, 973.9172170365528, 707.2255879811598, 713.3686687281742, 715.9642017899084, 719.7660760252938, 720.661289194078, 15151.621209469742, 15191.088534687955, 15209.391624335014, 15218.543443696706, 15338.386464541405, 10361.844572331345, 10409.843852342221, 10515.84226236607, 10572.52423640938, 10908.236423450362, 9586.568604412749, 9661.758456038655, 9945.552450139689, 10083.949580252125, 10565.577376904914, 2651.801114916389, 3178.6821317868257, 3182.904512864595, 3186.314942287396, 3208.1017315151794, 70238.64880675614, 73768.6311568444, 74194.62902685507, 74420.0, 74460.62769686172, 6174.197354343996, 7027.754028608974, 7201.4238860891, 7218.133823941161, 7397.927300541392, 12436.450527641811, 12482.251064936132, 12509.562165324352, 12520.624381268577, 12554.748905021848, 5549.38956714761, 6489.7404103835315, 6653.334666533405, 6733.326667333227, 6749.021391898147, 3969.980150099231, 4015.5181378234215, 4023.994001499625, 4031.4557534732435, 4033.193361327746, 3155.4793459079456, 3171.5559821624993, 3172.2069482629345, 3180.1572583264992, 3188.952165717516, 486.04977269438166, 486.14195944158587, 498.5388515623034, 505.2043032224262, 512.2188662290038, 557.8689008083097, 587.6386022596158, 596.6092209602717, 630.130420020369, 641.4002907281706, 8250.472183636977, 8745.562721863882, 8755.605997730117, 8863.911360886308, 8921.509316987627, 578.7169615865455, 589.6491587505427, 596.7634011548608, 630.2216762298558, 645.9709313080923, 2950.8524573771224, 3919.470871432377, 4076.7961601919787, 4107.794610269475, 4240.575942405735, 87021.56489217513, 97354.0264597345, 102544.48727756314, 102597.48701256595, 103313.0, 84397.0, 84703.0, 87323.0, 88259.0, 89869.0, 77639.835402469, 77653.0, 78082.0, 78396.0, 78688.0, 8609.65561377538, 8959.104089590988, 9010.14403631654, 9034.774130646523, 9194.770130746785, 55072.59419246371, 55184.896302074536, 55322.44677553334, 56656.15015774849, 58207.70896145492, 76519.8522022159, 76837.0, 77399.61300193463, 78364.82452763327, 79125.0, 8091.312238459562, 8116.310113640407, 8126.593670316579, 8172.7956801080445, 8224.588770561328, 12143.574974875837, 12197.451114699683, 12294.139410241198, 12706.87293127057, 12961.22232666043, 11617.709557261136, 11866.940665296619, 11890.821637675615, 11936.28382297065, 12183.878161218274, 10591.5233814477, 11806.82289765637, 11842.407879606157, 12031.15781895259, 12033.338166400932, 11291.0, 11306.604268850551, 11553.0, 11694.532218711496, 11886.34625095628, 9189.081091891025, 9817.852732209165, 9833.360831545926, 10052.497375131361, 10437.68686939393, 9903.702888913343, 9983.336234983784, 10066.44634545107, 10076.695458650678, 10113.848292275474], "unit": "ms", "name": "yui.html", "value": 6747.760483691592}], "name": "dromaeo_css", "value": 7186.498474999584}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [149.0, 152.0, 134.0, 115.0, 114.0, 127.0, 114.0, 115.0, 116.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 125.2}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 144.0, 155.0, 123.0, 144.0, 155.0, 121.0, 156.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.1}, {"lowerIsBetter": true, "replicates": [196.0, 196.0, 192.0, 193.0, 201.0, 204.0, 208.0, 216.0, 239.0, 195.0], "unit": "ms", "name": "audio-dft", "value": 204.0}, {"lowerIsBetter": true, "replicates": [56.0, 62.0, 62.0, 65.0, 107.0, 67.0, 82.0, 86.0, 86.0, 125.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 107.0, 76.0, 77.0, 79.0, 111.0, 75.0, 79.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 87.5}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 90.0, 128.0, 88.0, 87.0, 87.0, 86.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 94.0, 95.0, 96.0, 94.0, 128.0, 92.0, 149.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 108.8}, {"lowerIsBetter": true, "replicates": [138.0, 90.0, 81.0, 144.0, 148.0, 92.0, 119.0, 113.0, 91.0, 111.0], "unit": "ms", "name": "imaging-desaturate", "value": 112.7}, {"lowerIsBetter": true, "replicates": [56.0, 67.0, 91.0, 74.0, 59.0, 61.0, 59.0, 68.0, 60.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 65.2}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 65.0, 63.0, 67.0, 65.0, 67.0, 67.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 108.0, 108.0, 107.0, 82.0, 88.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 92.7}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 124.0, 128.0, 132.0, 121.0, 134.0, 138.0, 116.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [135.0, 138.0, 139.0, 138.0, 141.0, 138.0, 143.0, 142.0, 134.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [68.0, 86.0, 89.0, 91.0, 93.0, 91.0, 66.0, 68.0, 65.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 78.0}], "name": "kraken", "value": 1515.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [632.1112515802781], "unit": "score", "name": "Richards", "value": 55.84776399999999}, {"lowerIsBetter": false, "replicates": [157.0598397989634], "unit": "score", "name": "DeltaBlue", "value": 420.9733059999999}, {"lowerIsBetter": false, "replicates": [283.5270768358378], "unit": "score", "name": "Encrypt", "value": 938.8203869999999}, {"lowerIsBetter": false, "replicates": [4713.615023474178], "unit": "score", "name": "Decrypt", "value": 56.470670318725126}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [740.3846153846154], "unit": "score", "name": "Earley", "value": 900.1578181818184}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [657.030223390276], "unit": "score", "name": "Splay", "value": 124.02930199999997}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 19226.844866303574}]} 04:07:23 INFO - RETURN: dromaeo_css: 7186.50 04:07:23 INFO - RETURN: kraken: 1515.10 04:07:23 INFO - RETURN: v8_7: 19226.84 04:07:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "19226.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1515.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7186.50"}}} 04:07:23 INFO - Return code: 0 04:07:23 INFO - # TBPL SUCCESS # 04:07:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:23 INFO - 2015-11-19 04:07:23.983 screenresolution[1680:11005] starting screenresolution argv=screenresolution get 04:07:23 INFO - 2015-11-19 04:07:23.986 screenresolution[1680:11005] Display 0: 1600x1200x32@60 04:07:23 INFO - 2015-11-19 04:07:23.992 screenresolution[1681:11008] starting screenresolution argv=screenresolution list 04:07:23 INFO - Available Modes on Display 0 04:07:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:24 INFO - Intel Iris: 04:07:24 INFO - Chipset Model: Intel Iris 04:07:24 INFO - Type: GPU 04:07:24 INFO - Bus: Built-In 04:07:24 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:24 INFO - Vendor: Intel (0x8086) 04:07:24 INFO - Device ID: 0x0a2e 04:07:24 INFO - Revision ID: 0x0009 04:07:24 INFO - Displays: 04:07:24 INFO - Display: 04:07:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:24 INFO - Display Serial Number: 1600x1200 60 04:07:24 INFO - Main Display: Yes 04:07:24 INFO - Mirror: Off 04:07:24 INFO - Online: Yes 04:07:24 INFO - Rotation: Supported 04:07:24 INFO - Return code: 0 04:07:24 INFO - Running post-action listener: _resource_record_post_action 04:07:24 INFO - Running post-run listener: _resource_record_post_run 04:07:25 INFO - Total resource usage - Wall time: 1235s; CPU: 53.0%; Read bytes: 39179776; Write bytes: 692261888; Read time: 426; Write time: 2134 04:07:25 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 339552768; Write bytes: 334251520; Read time: 25853; Write time: 634 04:07:25 INFO - run-tests - Wall time: 1205s; CPU: 53.0%; Read bytes: 37066240; Write bytes: 346582528; Read time: 401; Write time: 1463 04:07:25 INFO - Running post-run listener: _upload_blobber_files 04:07:25 INFO - Blob upload gear active. 04:07:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:25 INFO - Copying logs to upload dir... 04:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.158924 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-19 04:07:25.379007) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 04:07:25.382954) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009488 build_url: 'https://queue.taskcluster.net/v1/task/qE_sPJAjSAWCp4Qj5dIGcA/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-19 04:07:25.409778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:07:25.410091) ========= 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.soxS1IrQJ9/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.b36ZriOQBM/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005182 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:07:25.458457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:07:25.458754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:07:25.459088) ========= ========= Total master_lag: 0.24 =========