builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1448404510.03 results: success (0) buildid: 20151124132732 builduid: af4e1138ee114202b37a86b6af893e9d revision: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.033790) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.034256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.034552) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005353 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.056691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.057027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.072176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.072714) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005256 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.126047) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.126365) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.126724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.126993) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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-24 14:35:10-- 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% 1.41G=0s 2015-11-24 14:35:10 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.255492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.256210) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.019955 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:10.312441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 14:35:10.312840) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a3e98127ebc28fcc01d27bdedb4c959a456c47d --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 8a3e98127ebc28fcc01d27bdedb4c959a456c47d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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-24 14:35:10,398 truncating revision to first 12 chars 2015-11-24 14:35:10,399 Setting DEBUG logging. 2015-11-24 14:35:10,399 attempt 1/10 2015-11-24 14:35:10,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a3e98127ebc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 14:35:12,082 unpacking tar archive at: fx-team-8a3e98127ebc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.931165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 14:35:12.260499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:12.260858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:12.272941) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:12.273391) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 14:35:12.273858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-24 14:35:12.274155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:12 INFO - MultiFileLogger online at 20151124 14:35:12 in /builds/slave/test 14:35:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:35:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:35:12 INFO - {'append_to_log': False, 14:35:12 INFO - 'base_work_dir': '/builds/slave/test', 14:35:12 INFO - 'blob_upload_branch': 'Fx-Team', 14:35:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:35:12 INFO - 'branch': 'Fx-Team', 14:35:12 INFO - 'buildbot_json_path': 'buildprops.json', 14:35:12 INFO - 'config_files': ('talos/mac_config.py',), 14:35:12 INFO - 'default_actions': ('clobber', 14:35:12 INFO - 'read-buildbot-config', 14:35:12 INFO - 'download-and-extract', 14:35:12 INFO - 'populate-webroot', 14:35:12 INFO - 'create-virtualenv', 14:35:12 INFO - 'install', 14:35:12 INFO - 'run-tests'), 14:35:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:35:12 INFO - 'download_minidump_stackwalk': True, 14:35:12 INFO - 'download_symbols': 'ondemand', 14:35:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:35:12 INFO - 'tooltool.py': '/tools/tooltool.py', 14:35:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:35:12 INFO - '/tools/misc-python/virtualenv.py')}, 14:35:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:35:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:35:12 INFO - 'installer_path': 'installer.exe', 14:35:12 INFO - 'log_level': 'info', 14:35:12 INFO - 'log_name': 'talos', 14:35:12 INFO - 'log_to_console': True, 14:35:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:35:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:35:12 INFO - 'opt_config_files': (), 14:35:12 INFO - 'pip_index': False, 14:35:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:35:12 INFO - 'cmd': ('bash', 14:35:12 INFO - '-c', 14:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:35:12 INFO - 'enabled': True, 14:35:12 INFO - 'halt_on_failure': False, 14:35:12 INFO - 'name': 'check_screen_resolution'},), 14:35:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:35:12 INFO - 'cmd': ('bash', 14:35:12 INFO - '-c', 14:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:35:12 INFO - 'enabled': True, 14:35:12 INFO - 'halt_on_failure': False, 14:35:12 INFO - 'name': 'check_screen_resolution'},), 14:35:12 INFO - 'run_cmd_checks_enabled': True, 14:35:12 INFO - 'sps_profile': False, 14:35:12 INFO - 'sps_profile_interval': 0, 14:35:12 INFO - 'suite': 'dromaeojs', 14:35:12 INFO - 'system_bits': '64', 14:35:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:35:12 INFO - 'title': 't-yosemite-r7-0001', 14:35:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:35:12 INFO - 'use_talos_json': True, 14:35:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:35:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:35:12 INFO - 'work_dir': 'build'} 14:35:12 INFO - ##### 14:35:12 INFO - ##### Running clobber step. 14:35:12 INFO - ##### 14:35:12 INFO - Running pre-action listener: _resource_record_pre_action 14:35:12 INFO - Running main action method: clobber 14:35:12 INFO - rmtree: /builds/slave/test/build 14:35:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:35:14 INFO - Running post-action listener: _resource_record_post_action 14:35:14 INFO - ##### 14:35:14 INFO - ##### Running read-buildbot-config step. 14:35:14 INFO - ##### 14:35:14 INFO - Running pre-action listener: _resource_record_pre_action 14:35:14 INFO - Running main action method: read_buildbot_config 14:35:14 INFO - Using buildbot properties: 14:35:14 INFO - { 14:35:14 INFO - "properties": { 14:35:14 INFO - "buildnumber": 20, 14:35:14 INFO - "product": "firefox", 14:35:14 INFO - "script_repo_revision": "production", 14:35:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:35:14 INFO - "repository": "", 14:35:14 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:35:14 INFO - "buildid": "20151124132732", 14:35:14 INFO - "slavename": "t-yosemite-r7-0001", 14:35:14 INFO - "pgo_build": "False", 14:35:14 INFO - "basedir": "/builds/slave/test", 14:35:14 INFO - "project": "", 14:35:14 INFO - "platform": "yosemite_r7", 14:35:14 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:35:14 INFO - "slavebuilddir": "test", 14:35:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:35:14 INFO - "branch": "fx-team", 14:35:14 INFO - "repo_path": "integration/fx-team", 14:35:14 INFO - "stage_platform": "macosx64", 14:35:14 INFO - "builduid": "af4e1138ee114202b37a86b6af893e9d", 14:35:14 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 14:35:14 INFO - }, 14:35:14 INFO - "sourcestamp": { 14:35:14 INFO - "repository": "", 14:35:14 INFO - "hasPatch": false, 14:35:14 INFO - "project": "", 14:35:14 INFO - "branch": "fx-team-macosx64-talos", 14:35:14 INFO - "changes": [ 14:35:14 INFO - { 14:35:14 INFO - "category": null, 14:35:14 INFO - "files": [ 14:35:14 INFO - { 14:35:14 INFO - "url": null, 14:35:14 INFO - "name": "https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 14:35:14 INFO - } 14:35:14 INFO - ], 14:35:14 INFO - "repository": "", 14:35:14 INFO - "rev": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d", 14:35:14 INFO - "who": "nalexander@mozilla.com", 14:35:14 INFO - "when": 1448403407, 14:35:14 INFO - "number": 6702152, 14:35:14 INFO - "comments": "Bug 1208605 - Try MOZ_ANDROID_PACKAGE_NAME env var before static ANDROID_PACKAGE_NAME. r=snorp", 14:35:14 INFO - "project": "", 14:35:14 INFO - "at": "Tue 24 Nov 2015 14:16:47", 14:35:14 INFO - "branch": "fx-team-macosx64-talos", 14:35:14 INFO - "revlink": "", 14:35:14 INFO - "properties": [ 14:35:14 INFO - [ 14:35:14 INFO - "buildid", 14:35:14 INFO - "20151124132732", 14:35:14 INFO - "Change" 14:35:14 INFO - ], 14:35:14 INFO - [ 14:35:14 INFO - "builduid", 14:35:14 INFO - "af4e1138ee114202b37a86b6af893e9d", 14:35:14 INFO - "Change" 14:35:14 INFO - ], 14:35:14 INFO - [ 14:35:14 INFO - "pgo_build", 14:35:14 INFO - "False", 14:35:14 INFO - "Change" 14:35:14 INFO - ] 14:35:14 INFO - ], 14:35:14 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 14:35:14 INFO - } 14:35:14 INFO - ], 14:35:14 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 14:35:14 INFO - } 14:35:14 INFO - } 14:35:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 14:35:14 INFO - Running post-action listener: _resource_record_post_action 14:35:14 INFO - ##### 14:35:14 INFO - ##### Running download-and-extract step. 14:35:14 INFO - ##### 14:35:14 INFO - Running pre-action listener: _resource_record_pre_action 14:35:14 INFO - Running main action method: download_and_extract 14:35:14 INFO - mkdir: /builds/slave/test/build/tests 14:35: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')]} 14:35:14 INFO - https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:35:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/test_packages.json 14:35:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/test_packages.json 14:35:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:35:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:35:15 INFO - Downloaded 1149 bytes. 14:35:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:35:15 INFO - Using the following test package requirements: 14:35:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:35:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 14:35:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'jsshell-mac.zip'], 14:35:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 14:35:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:35:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 14:35:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 14:35:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 14:35:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:35:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:35:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 14:35:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:15 INFO - https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:16 INFO - Downloaded 17527665 bytes. 14:35:16 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 14:35:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:35:19 INFO - Return code: 0 14:35:19 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 14:35: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')]} 14:35:19 INFO - https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:35:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:20 INFO - Downloaded 17527665 bytes. 14:35:20 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 14:35:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:35:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:35:23 INFO - Return code: 0 14:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:23 INFO - https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:25 INFO - Downloaded 11130997 bytes. 14:35:25 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 14:35:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:35:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:35:25 INFO - Return code: 0 14:35:25 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')]} 14:35:25 INFO - https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 14:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41x5b9jeRWCfg-efCS3o1w/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 14:35:28 INFO - Downloaded 109908853 bytes. 14:35:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:35:28 INFO - mkdir: /builds/slave/test/properties 14:35:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:28 INFO - Contents: 14:35:28 INFO - build_url:https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:35:28 INFO - Running post-action listener: _resource_record_post_action 14:35:28 INFO - Running post-action listener: set_extra_try_arguments 14:35:28 INFO - ##### 14:35:28 INFO - ##### Running populate-webroot step. 14:35:28 INFO - ##### 14:35:28 INFO - Running pre-action listener: _resource_record_pre_action 14:35:28 INFO - Running main action method: populate_webroot 14:35:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:28 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:35:28 INFO - '../fennec_ids.txt'], 14:35:28 INFO - 'tests': ['tcheck2']}, 14:35:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:28 INFO - '--tppagecycles', 14:35:28 INFO - '7'], 14:35:28 INFO - 'tests': ['tsvgm']}}, 14:35:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:35:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:35:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:35:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'tests': ['damp', 'tps']}, 14:35:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['damp', 'tps']}, 14:35:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:35:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:35:28 INFO - 'other': {'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'other_l64': {'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'other_nol64': {'tests': ['a11yr', 14:35:28 INFO - 'ts_paint', 14:35:28 INFO - 'tpaint', 14:35:28 INFO - 'sessionrestore', 14:35:28 INFO - 'sessionrestore_no_auto_restore']}, 14:35:28 INFO - 'svgr': {'tests': ['tsvgx', 14:35:28 INFO - 'tsvgr_opacity', 14:35:28 INFO - 'tart', 14:35:28 INFO - 'tscrollx', 14:35:28 INFO - 'cart']}, 14:35:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['tsvgx', 14:35:28 INFO - 'tsvgr_opacity', 14:35:28 INFO - 'tart', 14:35:28 INFO - 'tscrollx', 14:35:28 INFO - 'cart']}, 14:35:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'tests': ['tp5o']}, 14:35:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'talos_options': ['--e10s'], 14:35:28 INFO - 'tests': ['tp5o']}, 14:35:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'talos_options': ['--xperf_path', 14:35:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:28 INFO - 'tests': ['tp5n']}, 14:35:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:28 INFO - 'talos_options': ['--e10s', 14:35:28 INFO - '--xperf_path', 14:35:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:28 INFO - 'tests': ['tp5n']}}, 14:35:28 INFO - 'talos.zip': {'path': '', 14:35:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:28 INFO - Running post-action listener: _resource_record_post_action 14:35:28 INFO - ##### 14:35:28 INFO - ##### Running create-virtualenv step. 14:35:28 INFO - ##### 14:35:28 INFO - Running pre-action listener: _resource_record_pre_action 14:35:28 INFO - Running main action method: create_virtualenv 14:35:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:28 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 14:35:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:28 INFO - Using real prefix '/tools/python27' 14:35:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:35:29 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:32 INFO - Installing pip.................done. 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:32 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')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:32 INFO - 'HOME': '/Users/cltbld', 14:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PAGER': '/bin/cat', 14:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:32 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - 'XPC_FLAGS': '0x0', 14:35:32 INFO - 'XPC_SERVICE_NAME': '0', 14:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:32 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 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:35:32 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')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:32 INFO - 'HOME': '/Users/cltbld', 14:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PAGER': '/bin/cat', 14:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:32 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - 'XPC_FLAGS': '0x0', 14:35:32 INFO - 'XPC_SERVICE_NAME': '0', 14:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:32 INFO - Downloading/unpacking psutil>=0.7.1 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:35:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:34 INFO - Installing collected packages: psutil 14:35:34 INFO - Running setup.py install for psutil 14:35:35 INFO - building 'psutil._psutil_osx' extension 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 INFO - building 'psutil._psutil_posix' extension 14:35:35 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 14:35:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:35:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:35:35 INFO - ^ 14:35:35 INFO - 1 warning generated. 14:35:35 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 14:35:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:35 INFO - Successfully installed psutil 14:35:35 INFO - Cleaning up... 14:35:35 INFO - Return code: 0 14:35:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:35 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 14:35:35 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 14:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:35 INFO - 'HOME': '/Users/cltbld', 14:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:35 INFO - 'LOGNAME': 'cltbld', 14:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:35 INFO - 'MOZ_NO_REMOTE': '1', 14:35:35 INFO - 'NO_EM_RESTART': '1', 14:35:35 INFO - 'PAGER': '/bin/cat', 14:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:35 INFO - 'PWD': '/builds/slave/test', 14:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:35 INFO - 'SHELL': '/bin/bash', 14:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:35 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:35 INFO - 'USER': 'cltbld', 14:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:35 INFO - 'XPC_FLAGS': '0x0', 14:35:35 INFO - 'XPC_SERVICE_NAME': '0', 14:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:35:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:35:38 INFO - Installing collected packages: mozsystemmonitor 14:35:38 INFO - Running setup.py install for mozsystemmonitor 14:35:38 INFO - Successfully installed mozsystemmonitor 14:35:38 INFO - Cleaning up... 14:35:38 INFO - Return code: 0 14:35:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:38 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:38 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 14:35:38 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 14:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:38 INFO - 'HOME': '/Users/cltbld', 14:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:38 INFO - 'LOGNAME': 'cltbld', 14:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:38 INFO - 'MOZ_NO_REMOTE': '1', 14:35:38 INFO - 'NO_EM_RESTART': '1', 14:35:38 INFO - 'PAGER': '/bin/cat', 14:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:38 INFO - 'PWD': '/builds/slave/test', 14:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:38 INFO - 'SHELL': '/bin/bash', 14:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:38 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:38 INFO - 'USER': 'cltbld', 14:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:38 INFO - 'XPC_FLAGS': '0x0', 14:35:38 INFO - 'XPC_SERVICE_NAME': '0', 14:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:38 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 14:35:38 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 14:35:38 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 14:35:38 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 14:35:38 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 14:35:38 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 14:35:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - Downloading docopt-0.6.1.tar.gz 14:35:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:42 INFO - Running setup.py install for blobuploader 14:35:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:42 INFO - Running setup.py install for requests 14:35:42 INFO - Running setup.py install for docopt 14:35:42 INFO - Successfully installed blobuploader requests docopt 14:35:42 INFO - Cleaning up... 14:35:43 INFO - Return code: 0 14:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:43 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:43 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 14:35:43 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 14:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:43 INFO - 'HOME': '/Users/cltbld', 14:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:43 INFO - 'LOGNAME': 'cltbld', 14:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:43 INFO - 'MOZ_NO_REMOTE': '1', 14:35:43 INFO - 'NO_EM_RESTART': '1', 14:35:43 INFO - 'PAGER': '/bin/cat', 14:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:43 INFO - 'PWD': '/builds/slave/test', 14:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:43 INFO - 'SHELL': '/bin/bash', 14:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:43 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:43 INFO - 'USER': 'cltbld', 14:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:43 INFO - 'XPC_FLAGS': '0x0', 14:35:43 INFO - 'XPC_SERVICE_NAME': '0', 14:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-jX0c9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-vrdZHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-F6z60V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-rhE9As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-H6ec2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-nPUc_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:43 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-YwLaIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-Lgh4JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-5swgFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-NzmOj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-ATqb7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-F5CqB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-PPJWk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-gu4zdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-yILxJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-XGFrT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:44 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-37ZOZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:45 INFO - Running setup.py install for manifestparser 14:35:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:45 INFO - Running setup.py install for mozcrash 14:35:45 INFO - Running setup.py install for mozdebug 14:35:45 INFO - Running setup.py install for mozdevice 14:35:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:35:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:45 INFO - Running setup.py install for mozfile 14:35:45 INFO - Running setup.py install for mozhttpd 14:35:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:45 INFO - Running setup.py install for mozinfo 14:35:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Running setup.py install for mozInstall 14:35:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Running setup.py install for mozleak 14:35:46 INFO - Running setup.py install for mozlog 14:35:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Running setup.py install for moznetwork 14:35:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:46 INFO - Running setup.py install for mozprocess 14:35:46 INFO - Running setup.py install for mozprofile 14:35:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:47 INFO - Running setup.py install for mozrunner 14:35:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:47 INFO - Running setup.py install for mozscreenshot 14:35:47 INFO - Running setup.py install for moztest 14:35:47 INFO - Running setup.py install for mozversion 14:35:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:47 INFO - Cleaning up... 14:35:47 INFO - Return code: 0 14:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:47 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')]} 14:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:47 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')]} 14:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:47 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:47 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 14:35:47 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 14:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:47 INFO - 'HOME': '/Users/cltbld', 14:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:47 INFO - 'LOGNAME': 'cltbld', 14:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:47 INFO - 'MOZ_NO_REMOTE': '1', 14:35:47 INFO - 'NO_EM_RESTART': '1', 14:35:47 INFO - 'PAGER': '/bin/cat', 14:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:47 INFO - 'PWD': '/builds/slave/test', 14:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:47 INFO - 'SHELL': '/bin/bash', 14:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:47 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:47 INFO - 'USER': 'cltbld', 14:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:47 INFO - 'XPC_FLAGS': '0x0', 14:35:47 INFO - 'XPC_SERVICE_NAME': '0', 14:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:47 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-zixXI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-ykdFxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-xDqA_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-GOm5uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-yfcuUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-GyNI8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-UidXAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-QlGzn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-93M6jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:48 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)) 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:48 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-Qds5X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-HN5Zac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-gyO0CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-hzuv8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-km8Pnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-yFyVfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-nej4mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:49 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)) 14:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:49 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-DCY_nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:49 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)) 14:35:49 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)) 14:35:49 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)) 14:35:49 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)) 14:35:49 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)) 14:35:49 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)) 14:35:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:49 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 14:35:49 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 14:35:49 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 14:35:49 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 14:35:49 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 14:35:49 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 14:35:51 INFO - Downloading blessings-1.5.1.tar.gz 14:35:51 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 14:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:52 INFO - Installing collected packages: blessings 14:35:52 INFO - Running setup.py install for blessings 14:35:52 INFO - Successfully installed blessings 14:35:52 INFO - Cleaning up... 14:35:52 INFO - Return code: 0 14:35:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:52 INFO - Reading from file tmpfile_stdout 14:35:52 INFO - Current package versions: 14:35:52 INFO - blessings == 1.5.1 14:35:52 INFO - blobuploader == 1.2.4 14:35:52 INFO - docopt == 0.6.1 14:35:52 INFO - manifestparser == 1.1 14:35:52 INFO - mozInstall == 1.12 14:35:52 INFO - mozcrash == 0.16 14:35:52 INFO - mozdebug == 0.1 14:35:52 INFO - mozdevice == 0.47 14:35:52 INFO - mozfile == 1.2 14:35:52 INFO - mozhttpd == 0.7 14:35:52 INFO - mozinfo == 0.9 14:35:52 INFO - mozleak == 0.1 14:35:52 INFO - mozlog == 3.1 14:35:52 INFO - moznetwork == 0.27 14:35:52 INFO - mozprocess == 0.22 14:35:52 INFO - mozprofile == 0.27 14:35:52 INFO - mozrunner == 6.11 14:35:52 INFO - mozscreenshot == 0.1 14:35:52 INFO - mozsystemmonitor == 0.0 14:35:52 INFO - moztest == 0.7 14:35:52 INFO - mozversion == 1.4 14:35:52 INFO - psutil == 3.1.1 14:35:52 INFO - requests == 1.2.3 14:35:52 INFO - wsgiref == 0.1.2 14:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:52 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 0x10b587490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b564228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd720c95810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, '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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 14:35:52 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 14:35:52 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 14:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:52 INFO - 'HOME': '/Users/cltbld', 14:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:52 INFO - 'LOGNAME': 'cltbld', 14:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:52 INFO - 'MOZ_NO_REMOTE': '1', 14:35:52 INFO - 'NO_EM_RESTART': '1', 14:35:52 INFO - 'PAGER': '/bin/cat', 14:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:52 INFO - 'PWD': '/builds/slave/test', 14:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:52 INFO - 'SHELL': '/bin/bash', 14:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:35:52 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:52 INFO - 'USER': 'cltbld', 14:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:52 INFO - 'XPC_FLAGS': '0x0', 14:35:52 INFO - 'XPC_SERVICE_NAME': '0', 14:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 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)) 14:35:52 INFO - Cleaning up... 14:35:52 INFO - Return code: 0 14:35:52 INFO - Running post-action listener: _resource_record_post_action 14:35:52 INFO - Running post-action listener: _start_resource_monitoring 14:35:52 INFO - Starting resource monitoring. 14:35:52 INFO - ##### 14:35:52 INFO - ##### Running install step. 14:35:52 INFO - ##### 14:35:52 INFO - Running pre-action listener: _resource_record_pre_action 14:35:52 INFO - Running main action method: install 14:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:53 INFO - Reading from file tmpfile_stdout 14:35:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:53 INFO - Reading from file tmpfile_stdout 14:35:53 INFO - Output received: 14:35:53 INFO - Usage: mozinstall [options] installer 14:35:53 INFO - Options: 14:35:53 INFO - -h, --help show this help message and exit 14:35:53 INFO - -d DEST, --destination=DEST 14:35:53 INFO - Directory to install application into. [default: 14:35:53 INFO - "/builds/slave/test"] 14:35:53 INFO - --app=APP Application being installed. [default: firefox] 14:35:53 INFO - mkdir: /builds/slave/test/build/application 14:35:53 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'] 14:35:53 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 14:36:23 INFO - Reading from file tmpfile_stdout 14:36:23 INFO - Output received: 14:36:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:36:23 INFO - Running post-action listener: _resource_record_post_action 14:36:23 INFO - ##### 14:36:23 INFO - ##### Running run-tests step. 14:36:23 INFO - ##### 14:36:23 INFO - Running pre-action listener: _resource_record_pre_action 14:36:23 INFO - Running main action method: run_tests 14:36:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:23 INFO - 2015-11-24 14:36:23.688 screenresolution[1933:18108] starting screenresolution argv=screenresolution get 14:36:23 INFO - 2015-11-24 14:36:23.691 screenresolution[1933:18108] Display 0: 1600x1200x32@60 14:36:23 INFO - 2015-11-24 14:36:23.696 screenresolution[1934:18110] starting screenresolution argv=screenresolution list 14:36:23 INFO - Available Modes on Display 0 14:36:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:23 INFO - Intel Iris: 14:36:23 INFO - Chipset Model: Intel Iris 14:36:23 INFO - Type: GPU 14:36:23 INFO - Bus: Built-In 14:36:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:36:23 INFO - Vendor: Intel (0x8086) 14:36:23 INFO - Device ID: 0x0a2e 14:36:23 INFO - Revision ID: 0x0009 14:36:23 INFO - Displays: 14:36:23 INFO - Display: 14:36:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:23 INFO - Display Serial Number: 1600x1200 60 14:36:23 INFO - Main Display: Yes 14:36:23 INFO - Mirror: Off 14:36:23 INFO - Online: Yes 14:36:23 INFO - Rotation: Supported 14:36:23 INFO - Return code: 0 14:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:23 INFO - Python 2.7.3 14:36:23 INFO - Return code: 0 14:36:23 INFO - grabbing minidump binary from tooltool 14:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:23 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 0x10b4ab9f0>, '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 0x10b20adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b49e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:23 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 14:36:23 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 14:36:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:24 INFO - Return code: 0 14:36:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:36:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:36:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:24 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost'] in /builds/slave/test/build 14:36:24 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost 14:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjdKwhyMtZ/Render', 14:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:24 INFO - 'HOME': '/Users/cltbld', 14:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:24 INFO - 'LOGNAME': 'cltbld', 14:36:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:24 INFO - 'MOZ_NO_REMOTE': '1', 14:36:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:24 INFO - 'NO_EM_RESTART': '1', 14:36:24 INFO - 'PAGER': '/bin/cat', 14:36:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:24 INFO - 'PWD': '/builds/slave/test', 14:36:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:24 INFO - 'SHELL': '/bin/bash', 14:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L40F9BrJAg/Listeners', 14:36:24 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 14:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:24 INFO - 'USER': 'cltbld', 14:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:24 INFO - 'XPC_FLAGS': '0x0', 14:36:24 INFO - 'XPC_SERVICE_NAME': '0', 14:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:24 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost'] with output_timeout 3600 14:36:24 INFO - mozversion INFO | application_buildid: 20151124132732 14:36:24 INFO - mozversion INFO | application_changeset: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d 14:36:24 INFO - mozversion INFO | application_display_name: Nightly 14:36:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:24 INFO - mozversion INFO | application_name: Firefox 14:36:24 INFO - mozversion INFO | application_remotingname: firefox 14:36:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 14:36:24 INFO - mozversion INFO | application_vendor: Mozilla 14:36:24 INFO - mozversion INFO | application_version: 45.0a1 14:36:24 INFO - mozversion INFO | platform_buildid: 20151124132732 14:36:24 INFO - mozversion INFO | platform_changeset: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d 14:36:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 14:36:24 INFO - mozversion INFO | platform_version: 45.0a1 14:36:24 INFO - 2015-11-24 14:36:24,238 DEBUG : using testdate: 1448404584 14:36:24 INFO - 2015-11-24 14:36:24,238 DEBUG : actual date: 1448404584 14:36:24 INFO - 2015-11-24 14:36:24,609 INFO : starting webserver on 'localhost:57267' 14:36:24 INFO - 2015-11-24 14:36:24,610 INFO : Starting test suite t-yosemite-r7-0001 14:36:24 INFO - 2015-11-24 14:36:24,610 INFO : Starting test dromaeo_css 14:36:24 INFO - 2015-11-24 14:36:24,610 DEBUG : operating with platform_type : mac_ 14:36:24 INFO - 2015-11-24 14:36:24,612 INFO : Initialising browser for dromaeo_css test... 14:36:24 INFO - 2015-11-24 14:36:24,623 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpeeUdSR/profile http://localhost:57267/getInfo.html 14:36:26 INFO - 2015-11-24 14:36:26,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:36:26 INFO - 2015-11-24 14:36:26,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:36:26 INFO - 2015-11-24 14:36:26,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:36:26 INFO - 2015-11-24 14:36:26,635 DEBUG : BROWSER_OUTPUT: __metrics 14:36:26 INFO - 2015-11-24 14:36:26,655 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:36:27 INFO - 2015-11-24 14:36:27,350 INFO : Browser initialized. 14:36:27 INFO - 2015-11-24 14:36:27,350 INFO : Running cycle 1/1 for dromaeo_css test... 14:36:27 INFO - 2015-11-24 14:36:27,351 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpeeUdSR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:36:39 INFO - 2015-11-24 14:36:39,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 226156544 14:36:39 INFO - 2015-11-24 14:36:39,237 DEBUG : BROWSER_OUTPUT: 14:37:30 INFO - 2015-11-24 14:37:30,821 DEBUG : BROWSER_OUTPUT: 1448404650814 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] 14:39:41 INFO - 2015-11-24 14:39:41,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57267/tests/dromaeo/cssquery-ext.html) 14:39:42 INFO - 2015-11-24 14:39:42,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 380346368 14:39:42 INFO - 2015-11-24 14:39:42,792 DEBUG : BROWSER_OUTPUT: 14:42:45 INFO - 2015-11-24 14:42:45,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-ext.html (next: http://localhost:57267/tests/dromaeo/cssquery-jquery.html) 14:42:46 INFO - 2015-11-24 14:42:46,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 366206976 14:42:46 INFO - 2015-11-24 14:42:46,215 DEBUG : BROWSER_OUTPUT: 14:45:48 INFO - 2015-11-24 14:45:48,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57267/tests/dromaeo/cssquery-mootools.html) 14:45:48 INFO - 2015-11-24 14:45:48,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 327966720 14:45:48 INFO - 2015-11-24 14:45:48,917 DEBUG : BROWSER_OUTPUT: 14:48:51 INFO - 2015-11-24 14:48:51,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57267/tests/dromaeo/cssquery-prototype.html) 14:48:51 INFO - 2015-11-24 14:48:51,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 320049152 14:48:51 INFO - 2015-11-24 14:48:51,650 DEBUG : BROWSER_OUTPUT: 14:51:54 INFO - 2015-11-24 14:51:54,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57267/tests/dromaeo/cssquery-yui.html) 14:51:55 INFO - 2015-11-24 14:51:55,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 321945600 14:51:55 INFO - 2015-11-24 14:51:55,350 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-yui.html (next: http://localhost:57267/tests/dromaeo/cssquery-dojo.html) 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 365244416 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:54:58 INFO - 2015-11-24 14:54:58,580 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:54:58 INFO - 2015-11-24 14:54:58,582 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3073.830939298339;3366.4950257461364;3413.7781044232124;3427.8628854845792;3439.7076248518883;5470.589705772073;5628.718564071795;5631.662100273976;5691.459311365424;5728.598998070137;5591.881623675261;5609.214709940612;5675.6878371689545;5788.363280039192;5804.767809287623;5064.620153488485;5067.721275329855;5117.437081920985;5157.664751791141;5204.115300398922;5195.19474481456;5197.558207552363;5202.985417843522;5230.189320655304;5265.657732247391;5049.368828896388;5131.794728210886;5151.201563757623;5151.304573882516;5177.430482646943;4425.402570652985;5092.26162206478;5155.53600175986;5162.406323272834;5167.3282473278605;5082.974585127087;5109.4379618241965;5117.948820511784;5148.176291793295;5162.483751624845;5638.887222255573;5648.519875810561;5652.954203472371;5664.830055098354;5668.121441176624;6098.756049758004;6151.384861513858;6154.938450615526;6166.599171053867;6175.814725558195;6290.905636415458;6297.559170858041;6320.178376811031;6330.493560515148;6332.936670633281;5748.626339287933;5860.179574859523;5860.970695146497;5863.208466856962;5864.912026319608;5963.493103086286;6047.9395206047375;6126.969365153235;6267.122602835607;6284.937150628435;5264.52619264268;6050.6974651267265;6071.119687645267;6076.939230607726;6077.392260773887;6219;6293.874122517524;6304.432601065926;6304.905426418607;6305.4009869062365;5967.6121052131475;6101.328853826076;6104.267487901391;6217.96891015542;6223.408776166257;6125.215553761287;6139.785107521216;6142.095950255435;6142.529470848956;6148.1085242639565;4849;4911.312416261726;4923.113839508923;4927.211646136601;4933.555979961749;4358.4769827620885;4412.889677758082;4415.227335216325;4425.535318791545;4449.755263460541;5675.1770993205755;5699.487046165865;5706.71466426677;5710.029295019856;5712.028955077647;6075.635461872302;6145.432914606836;6149.692515374213;6283.497320214372;6296.622202667854;5624.353199382042;5630.268065151504;5637.26715526987;5640.379558248589;5648.124540696199;5411.161270003156;5415.729213539307;5416.891662166735;5425.593080518976;5461.863453413696;6283.277423096311;6295.527835412362;6317.778877739257;6326.272478664829;6327.335629758901;6080.726367313393;6166.136740856194;6305.180326557518;6317.336679648571;6331.461825744863;6188.752449901954;6277.372262773686;6281.466075383643;6282.2147231596055;6300.369963003846;6080.915733170807;6110.40687992437;6135.417135372132;6142.464383904024;6156.415140561639;6244.562880598496;6259;6259.65571893532;6264.404881536247;6267.373262673696;5841.561882858888;5900.852478688067;5978;6022.759089636365;6031.728572214349;5950.702464876826;6003.159557661844;6017.578769486094;6026.397360263939;6070.848228794315;5862.325832529314;5903.026000710007;5936.614120082181;5954.434328738763;5957.314908785545;5751;5932.525397968066;5953.017752070859;6096.0855871619615;6097.359777223505;5873.765049397976;5952.8809423812145;5954.523638108854;5967.91048134287;5982.910256346071 14:54:58 INFO - 2015-11-24 14:54:58,583 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.7060131626947;546.3089192171901;585.2508788750399;602.6655206360474;630.2374127305959;32319;32749.345013099723;32807.343853122955;32815.50776738351;32928.67071329289;33598.32803343931;33962.81130160445;34008.14979625511;42966.35550466745;43451;9769.658061967815;9886.258530610197;9899.90100098997;9936.503174841266;9948.60205591779;9498.002709715483;9562.569684364185;9575;9580.185684216814;9629.807403851919;8910.33172512061;8969.058248883872;8982.146696063863;11947.522099116024;12093.03255739543;11860.703482412922;11959.40202989847;11966.880331196751;11972.461239244254;11984.161108722394;8876.644934202624;11736.471858766376;11894.940525297405;11915.880841191563;11924.046076313874;32146.357072858413;32364;32496.512552311735;32551.02346929596;43066.56933430657;3142.261568531393;3172.0959526535057;3177.2374630088843;3216.2281052547455;3778.5087938568086;24318.78406079689;28898.42203155925;29069.85465072661;29573.55639665407;29621.45645900523;2773.3066733316673;2792.176307989148;2849.7435230829324;2877.208767588909;2974.0631701014113;468765.1234876485;470994.32045436284;471252.99999999657;471390;471550;63773.40566485782;63778;63971.360286397474;64361.35638643647;69101.30898690948;62030;76326.61836690892;77390.6130469344;77418.6129069351;77516;16328.75506867398;16488.422905198262;16641.16794160287;16642.417515386904;16723.49829505117;12573.245605263714;12637.620871373874;12637.620871373874;12638.684032899067;12775.61673149807;22097.558048839255;22161.22435714742;22244.55510889773;22247.22134725277;22309.665355019686;8606.31149508038;8785.604647790864;8823;8831.498645230326;8861.24679402245;936.3726303376754;980.7989362180735;980.9950950245203;1073.7798751255973;1104.5747387255965;29504.409911801642;29812.10563683093;29854.40291194164;30526.38947221043;30607.540886886716;992.9982171847466;1042.8331466965249;1050.922804125762;1109.389835590422;1172.976540469186;14983.625409364635;15208.619784505254;15347.309371078329;15527.84472155264;15570.221488925736;444566;532374;537875.3106234444;538218.308908453;539430;59414.811703765685;59466.10800837991;59590;59622.40377596255;59687.701561491915;1460.5545308680742;1473.2486431920013;1483.770015647598;1485.6508720450686;1597.9920100399424;29773.5533966995;30167.698323016488;30479.390412192075;30501.694983050773;31176;54260.728696356266;54640.18039729487;54687.45312546983;54708.72645636746;54719;393144;394499;395778;396071;396319;28272;28738.99413520517;28829.56755648625;31660.5250921241;33833.49249761305;42547.93630159147;42805.35791963185;43022;44327.33508997303;44457.99878010995;35886.64113358833;36077.189055223425;36561.26877462489;36579.45130823093;36721.81639091788;32448.513272301407;35098.29803403969;35694.82152589221;35886.82056589805;36212;35686.929392118276;36680.44979325259;36925.446118308784;36938.26123477462;36940.63059369372;30055.948041818432;30397.392052159274;32427.18932026718;32510.699572016856;33206.83396583002;24234.39414014593;24299.757002430455;24553.75446245515;24702.505949880542;24814.88333024982 14:54:58 INFO - 2015-11-24 14:54:58,587 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.06105534028524;361.92037751694625;362.9981850090749;363.62728203591325;363.91811842335477;15772.684546309067;16021;19108.331208407708;19727;20478.488037799063;17041.06274154921;17472.21375038123;17531.64936701265;18426.44720658379;20862.269820556285;5800.071988481844;5837.066069428903;5909.468147866691;5919.052951527757;5920.023196172627;4213.726107802999;4335.826566937319;4340.392345071693;5863.120531920204;5931.317898441691;6315.273743519485;6428.389303016229;6474.028895665664;6475.676216189196;6477.578957367756;6297.181366422359;6528.967355163241;6529.967350163242;6532.7713530026695;6534.901976470333;5512.944870551283;5632.267805185341;5640.802571910004;5645.633033852787;5646.745896434671;24866.50266994668;24909.62635560468;24954.50090998188;25099.62350564743;25472.363190920376;2081.323569839808;2083.447886310129;2086.968695469569;2103.9425274194587;2125.4686328417897;9186.356955013152;14960.952733308673;15047.021943573633;15300.08199508033;15554.688906221925;1700.3113738935751;1740.7649967254386;1746.9912650436793;1767.823217678222;1774.8313910178513;82340;98000.50999745027;100980;101805.9819401804;102573.48713256385;8910.732678019669;10904.61833835812;10931.945340273407;10992.670219893416;11005.944970275097;13147.60557183286;13168.60494185176;13192.670183245304;13195.274259915797;13203.40584673692;8061.355091592776;8234.176582341717;8250.422470427133;8331.250187483156;8338.99932008163;7971.043474783063;8341.499510029418;8354.916450835535;8363.749087527383;8434.367422443342;3736.5702944161226;4255.87232383029;4289.699721019561;4292.59220374064;4302.225599392077;1418.9219592922489;1698.100006996294;1752.7195648696402;1754.5438186071713;1775.1568005197687;881.2113158722907;941.773974246176;944.5182956691999;1021.8211812932707;1027.7204879924393;17010.319587216374;19696.507587310432;19797.505062373555;19875.403737887886;19889.60220795576;795.1134485049245;845.2688424512752;877.7981064355106;908.9636414543477;943.5895385507326;7481.289277518627;10687.78624427507;10698;10734.409607471507;10737.83893241602;727347;744040;744259;767906;769794;116441;120880;121287.39356303163;121883;122236;1162.3897453836635;1169.9532018719156;1178.9941050294694;1184.4373922386796;1230.5323976888903;18786.06069696537;18853.811461885205;18912.338068167548;19011.714824277922;19047.619047619246;51203.743981279855;51600.48399515957;51728.63763855337;51781.7410912943;52636.47363526316;70275;70971.64514177396;71231.93152102618;72797.6360118196;75052.62473687815;7984.880226796487;9665.371750836173;9684.75788105303;9751.707448776548;9775.608975640895;17873.553161171076;19738.80261197427;19882.801171988674;20209.292674756314;20516.897415512827;15225.086494810346;15474;15846.920765396098;15876.60308492297;16109.677806443571;15009.024413413093;15433.84566154324;15455.61360965985;15466.381344746083;15705.450309239122;11748.88251117478;15763.842361576697;15789.921050394674;16263.512094637179;16325.59186020359;9593.952030239805;9678.564464598969;9732.610695572097;9755.658551950648;9761.707148785548;15183.696326073195;15706.21468926572;15841.207939603204;15844.970076945423;15864.762028569812 14:54:58 INFO - 2015-11-24 14:54:58,588 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1574.2050264616366;1580.0835515401068;1622.9369762805366;1904.523869032742;1912.6652835753741;7005.579665220091;7797;7800.531968081919;8250.133735957728;8378.832423351529;8164.38767092469;8209.876851847212;8256.380771442136;8270.875936860952;8280.130586288444;2024.7570291565032;2328.976710232897;2348.5068135691527;2348.9765102349015;2351.706036745407;2127.819135373495;2162.264829957814;2168.56628674265;2341.730700969393;2394.473215892501;2292.805111565519;2340.5435939991708;2341.4029422497324;2344.542814151241;2349.34218418843;2099.737532808399;2317.7566355532595;2352.400137964808;2354.846934949223;2355.281639100074;2074.0666699985068;2094.172801743318;2151.5051538146313;2159.3845753960045;2160.6758986152045;8074.152214017561;8197.139300373434;8201.671933122727;8203.58982050895;8205.58972051401;5106.285120083191;5158.484151584849;5158.509941555546;5192.013517431714;5193.532582067594;3420.26464310172;3496.3531746626954;3535.5934067582302;3544.078539579702;3547.0068380853404;1022.1465076660998;1039.7816458543714;1044.4725413666126;1051.526812934175;1068.8076146293663;10859.914008599157;10875.510602022929;10883.83674244887;10896.128309735202;10909.618163364323;4581.289900065495;4582.862514124515;4666.789994450258;4675.812967481331;4682.484926658065;7835.6473958671995;8201.13888041747;9543.42739435636;9585.424874507551;9588.904110958802;5141.408737995103;5177.430482646906;5180.611454140954;5189.610779191576;5194.844154675366;4690.296455531698;4692.882677933011;4726.905461890743;4727.787249573777;4730.645201609893;3239.2549713566013;3733.3466643337306;3830.6935445164877;3847.1920896612023;3864.091938394475;1246.8067449545154;1263.633546271571;1265.5570550307318;1270.8093785932185;1270.9618711438673;1343.596920923719;1364.836219653628;1385.49429458247;1392.3455975691409;1396.685745707228;7647.197044310267;7817.843643127106;7820;7825.256600622932;7844.882326765103;490.83557008402585;504.44511037858064;506.6782593053438;507.9796808127634;508.9083964886356;5669.943300567024;5767.942320576824;6122.969385153046;6193.411625895533;6199.3490683477585;9183.173514383738;9791.363561368631;9866.963968783319;9887.752806179758;9931.702048938543;9437.716868493957;9653.613855445845;9758.95120524407;9859.950700246596;9929.2056635469;7811.140774514799;7942.6425810838655;7947.602619868983;7950.403719721044;7953.204679532117;7574.545527268381;7717.1896950819355;7772.92227077722;7773.844523109619;7781.06627204739;8700.91299087001;8924;8957.14907083826;9023.503707296162;9069.138431848964;9007.954960225157;9322.906770932204;9385.15533601979;9435.622575096919;9473.384230025027;6317.936820631735;7236.421086312977;7269.236730143259;7295.306945840137;7347.70609175627;7870;7923.049234091945;7931.762047138595;7941.00737407824;7943.761687149395;7287.1984081752025;7352.485326027127;7360.411167106511;7505.737299194502;7526.983857179211;7241.131064272321;7264.818379540554;7358.264173582813;7382.889256661262;7384.741534046282;6956.478264130109;7283.198848126808;7293.671784769592;7304.306090921354;7338;6163.8150855474405;6782.321767823179;6816.829579260359;6823.624700641512;6831.077804496329;6747.089142965833;6850.794476165723;6865;6892.276310987475;6900.068490753884 14:54:58 INFO - 2015-11-24 14:54:58,590 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.4708339363332;330.23715217846774;331.69981167043835;334.6108783287327;334.7071312601474;6855.41728953039;6881.277465866081;6892.620905850183;7003.089598352207;7052.942058691199;6900.482463815209;6911.654417279141;6913.723451061964;6920.377166055054;6922.861542769142;4877.561019508244;5028.622853286;5049.116404629193;5049.722265275408;5053.797848086081;5029.647924645276;5041.092603331417;5046.470120637336;5061.848144555651;5075.340205773245;4975.577075948549;4977.576905962997;4978.402591688984;4981.626378021663;4990.401151861782;4741.762911854428;4825.5174482551465;4870.561649451531;4982.252662100677;4998.450170481262;4221.493420789494;4247.469066366704;4271.380649805792;4288.16380805743;4307.655387568987;6563.212414510242;6579.769708060243;6605.108310378086;6611.338866113399;6612.537122401433;5594.2447769551;5681.772729090872;5854.619449735754;5881.47066763989;6013.939860601426;7235.638218089074;7249.78250652476;7365.373943214833;7368.926310736878;7385.929040289182;4816.8073277069225;4816.927746083811;4821.855344339676;4826.4690884003085;4830.73430961297;7243.5653860768525;7276.235995220479;7508.361789247921;7804.3756499479905;7806.282617824069;4713;4723.055388922229;4724.645651576146;4725.692829966041;4735.59747421473;4783.856484305476;4790.712557246577;4808.975955120202;4810;4817.927731084036;5755.625884317506;5762.798302059407;5768.913466298009;5771.394003629558;5773.653580785166;7144.879519568438;7251.891221631679;7320.1581818090535;7335.193128755833;7338.5596864187255;1653.330401187521;1684.5956970327034;1686.5024817678814;1686.7216909209842;1686.9325226990784;1053.4732633683159;1061.6655753437642;1072.2494254022215;1081.6538707613488;1083.1389045708681;6860.5540639858245;6867.381935625718;6873.20958089816;6881.552699074544;6891.27641597635;7627.084749830056;7630.008098947102;7639.159692433828;7648.770536883902;7648.847023059508;6703.095082163943;6834.829129271709;6838.213605435439;6839.692213850389;6965.651717414109;3921.9607803922167;4021.4571032910767;4022.054817117975;4069.694772892045;4106.445629839993;6310.9368906311265;7860.135385107634;7874.881876771853;8054.114047454776;8082.878756818653;8050.83898322042;8059.314958228499;8068.636911339004;8081.151479094728;8082.878756818653;6741.954996975379;7805.180456052146;7898.763037108896;8041.6381262843315;8050.396220283385;7442.516236444614;7759.146493885555;7777;7780.92219077802;7781.610919454118;6564.704588293634;7412.110546734426;7548.433867459853;7624.733134340271;7634.427417943565;7104.538205016657;7432.479726419098;8019.719309824128;8025.879611805711;8033.11635720082;4711.835085772119;4760.9047819042735;4770;4773.904521909473;4778.856634300976;5828.854278643068;7378.335949764547;7422;7681.5775132366025;7712.961435193012;7393.223711510429;7400.703971841066;7417.443691723034;7426.480146389917;7433.516821406592;7371.115466144097;7395.371393431618;7408.185099638928;7419.29516695913;7419.740309089156;7048.894266586108;7262.455315851226;7270.491065625355;7277.672504737194;7279.344858962719;7426;7433.553986760811;7437.665305061393;7450.552966822008;7451.701931922662;6490.448311893542;6729.865402692017;7046;7214.74748383804;7282 14:54:58 INFO - 2015-11-24 14:54:58,591 DEBUG : BROWSER_OUTPUT: |5;yui.html;734.7097896330949;749.2208103572285;750.1785544828415;789.5578476053411;836.8075342671185;13401.92784577234;14014.649633759162;14546.199959002251;14918.627034324147;14923.328450219738;12799.232046077219;13805.37875795589;13932.999999999975;13939.442422303122;13951.441942322295;714.4605822603927;943.4433684126365;962.1052421248237;963.2871674960548;965.0012237334361;950.2208189284789;954.374884450686;963.2149797914713;968.4625033106623;968.7674958010062;772.7102336623766;783.7452827830949;841.869510225916;1014.8173328800813;1016.9389836609827;774.7017398301638;983.5475681186663;1021.9284650074497;1023.380854582974;1027.250107421579;742.1168809117133;742.8031571633521;743.275306576084;744.1851172965594;744.5904752386166;14547.563573092824;15033.774493382609;15063.849361506464;15097.3206205721;15120.243987800566;12684.175528590613;12724.300163491005;12866.549670761478;13188.406521706545;13551.051426400156;10385.688429347132;10407.33482642781;10536.789264214673;10750.139988800876;11023.118150548016;3594.137407022322;3618.999499700301;3634.036980200249;3643.307771523402;3688.963110368889;64423.355766442204;81724.59137704333;81940.59029704814;81953;82138.17861821366;9937.205023598095;10125.746856328651;10278.229132814919;10403.21975851799;10788.730281743019;17760.467185984442;17917.910410447865;22747.97634106436;23036.96333664989;23040;7326.523775954546;7485.0643669541305;7617.847643047219;7642.821795788285;7772.65023073963;3814.294355544233;3838.05967537955;3845.0771814764257;3915.275674000262;4034.23349563582;3459.6021457532706;3500.4749287607065;3501.089716673683;3502.7022703070525;3508.122969257686;595.9642421454727;657.4937298280392;659.6108296105225;666.2105405094978;672.9764458243937;468.81857718549065;481.73745308806787;489.29297165596086;514.9974250128726;532.1379365427954;8307.08622051574;8558.61486233121;8580.785480362916;8655.221030107321;8743.868841967376;524.2529395611239;525.5637820608886;550.840256325661;607.5291648971994;639.3478651775164;3773.4905787718853;3970.920581588352;4038.394240863835;4087.5094988600963;4234.195502854448;91161.54419227994;91866;92017;92462;92924;77474.67575972617;77819.61090194626;79163.20836791674;86887.56556217179;87347;73155;74587.62706186435;78187.21812781913;79244.60377698074;80059.19940800635;8925.776855578662;8972.775680608038;9047.68333108338;9108.271338293052;9211.263098952202;50696.23955640742;50809.49434052733;53213;53564.73217633887;55617;74601.62699186469;74663.62668186841;75672.62163689146;77061.84407234009;78390.60804696169;11004.284721493077;11063.944680276869;11159.38623375722;11184.993350598485;11801.645950621494;12019.879801201876;12046.337451439904;12115.273083615011;12150.939245303716;12554.686132846751;11764.470598823245;11852.76294474123;11863.525458981889;11962.76074478523;12035.819462708241;11914.285142891455;11929.164958452826;11957.940210298893;11981.221220620631;12067;11471.655850324503;11715.472803723682;11760.705982350168;11791.705207369885;11874;9456.479893605918;9647.469389183661;10001.299779037436;10008.249381296577;10179.592816287266;8033.758987230392;9783.315167938175;9822.607095716092;9866.753331166778;9963.750906227402 14:54:58 INFO - 2015-11-24 14:54:58,591 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:54:58 INFO - 2015-11-24 14:54:58,591 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1263 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1448405698579__endTimestamp 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,592 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5699.91 Median:5932.53 stddev:642.60 (10.8%) stddev-sans-first:610.65 14:54:58 INFO - 2015-11-24 14:54:58,594 DEBUG : BROWSER_OUTPUT: Values: 3073.8 3366.5 3413.8 3427.9 3439.7 5470.6 5628.7 5631.7 5691.5 5728.6 5591.9 5609.2 5675.7 5788.4 5804.8 5064.6 5067.7 5117.4 5157.7 5204.1 5195.2 5197.6 5203.0 5230.2 5265.7 5049.4 5131.8 5151.2 5151.3 5177.4 4425.4 5092.3 5155.5 5162.4 5167.3 5083.0 5109.4 5117.9 5148.2 5162.5 5638.9 5648.5 5653.0 5664.8 5668.1 6098.8 6151.4 6154.9 6166.6 6175.8 6290.9 6297.6 6320.2 6330.5 6332.9 5748.6 5860.2 5861.0 5863.2 5864.9 5963.5 6047.9 6127.0 6267.1 6284.9 5264.5 6050.7 6071.1 6076.9 6077.4 6219.0 6293.9 6304.4 6304.9 6305.4 5967.6 6101.3 6104.3 6218.0 6223.4 6125.2 6139.8 6142.1 6142.5 6148.1 4849.0 4911.3 4923.1 4927.2 4933.6 4358.5 4412.9 4415.2 4425.5 4449.8 5675.2 5699.5 5706.7 5710.0 5712.0 6075.6 6145.4 6149.7 6283.5 6296.6 5624.4 5630.3 5637.3 5640.4 5648.1 5411.2 5415.7 5416.9 5425.6 5461.9 6283.3 6295.5 6317.8 6326.3 6327.3 6080.7 6166.1 6305.2 6317.3 6331.5 6188.8 6277.4 6281.5 6282.2 6300.4 6080.9 6110.4 6135.4 6142.5 6156.4 6244.6 6259.0 6259.7 6264.4 6267.4 5841.6 5900.9 5978.0 6022.8 6031.7 5950.7 6003.2 6017.6 6026.4 6070.8 5862.3 5903.0 5936.6 5954.4 5957.3 5751.0 5932.5 5953.0 6096.1 6097.4 5873.8 5952.9 5954.5 5967.9 5982.9 14:54:58 INFO - 2015-11-24 14:54:58,594 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,594 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61335.62 Median:33715.91 stddev:123423.68 (366.1%) stddev-sans-first:123685.48 14:54:58 INFO - 2015-11-24 14:54:58,595 DEBUG : BROWSER_OUTPUT: Values: 529.7 546.3 585.3 602.7 630.2 32319.0 32749.3 32807.3 32815.5 32928.7 33598.3 33962.8 34008.1 42966.4 43451.0 9769.7 9886.3 9899.9 9936.5 9948.6 9498.0 9562.6 9575.0 9580.2 9629.8 8910.3 8969.1 8982.1 11947.5 12093.0 11860.7 11959.4 11966.9 11972.5 11984.2 8876.6 11736.5 11894.9 11915.9 11924.0 32146.4 32364.0 32496.5 32551.0 43066.6 3142.3 3172.1 3177.2 3216.2 3778.5 24318.8 28898.4 29069.9 29573.6 29621.5 2773.3 2792.2 2849.7 2877.2 2974.1 468765.1 470994.3 471253.0 471390.0 471550.0 63773.4 63778.0 63971.4 64361.4 69101.3 62030.0 76326.6 77390.6 77418.6 77516.0 16328.8 16488.4 16641.2 16642.4 16723.5 12573.2 12637.6 12637.6 12638.7 12775.6 22097.6 22161.2 22244.6 22247.2 22309.7 8606.3 8785.6 8823.0 8831.5 8861.2 936.4 980.8 981.0 1073.8 1104.6 29504.4 29812.1 29854.4 30526.4 30607.5 993.0 1042.8 1050.9 1109.4 1173.0 14983.6 15208.6 15347.3 15527.8 15570.2 444566.0 532374.0 537875.3 538218.3 539430.0 59414.8 59466.1 59590.0 59622.4 59687.7 1460.6 1473.2 1483.8 1485.7 1598.0 29773.6 30167.7 30479.4 30501.7 31176.0 54260.7 54640.2 54687.5 54708.7 54719.0 393144.0 394499.0 395778.0 396071.0 396319.0 28272.0 28739.0 28829.6 31660.5 33833.5 42547.9 42805.4 43022.0 44327.3 44458.0 35886.6 36077.2 36561.3 36579.5 36721.8 32448.5 35098.3 35694.8 35886.8 36212.0 35686.9 36680.4 36925.4 36938.3 36940.6 30055.9 30397.4 32427.2 32510.7 33206.8 24234.4 24299.8 24553.8 24702.5 24814.9 14:54:58 INFO - 2015-11-24 14:54:58,595 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,596 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38872.78 Median:2114.71 stddev:123470.19 (5838.6%) stddev-sans-first:123782.69 14:54:58 INFO - 2015-11-24 14:54:58,597 DEBUG : BROWSER_OUTPUT: Values: 359.1 361.9 363.0 363.6 363.9 15772.7 16021.0 19108.3 19727.0 20478.5 17041.1 17472.2 17531.6 18426.4 20862.3 5800.1 5837.1 5909.5 5919.1 5920.0 4213.7 4335.8 4340.4 5863.1 5931.3 6315.3 6428.4 6474.0 6475.7 6477.6 6297.2 6529.0 6530.0 6532.8 6534.9 5512.9 5632.3 5640.8 5645.6 5646.7 24866.5 24909.6 24954.5 25099.6 25472.4 2081.3 2083.4 2087.0 2103.9 2125.5 9186.4 14961.0 15047.0 15300.1 15554.7 1700.3 1740.8 1747.0 1767.8 1774.8 82340.0 98000.5 100980.0 101806.0 102573.5 8910.7 10904.6 10931.9 10992.7 11005.9 13147.6 13168.6 13192.7 13195.3 13203.4 8061.4 8234.2 8250.4 8331.3 8339.0 7971.0 8341.5 8354.9 8363.7 8434.4 3736.6 4255.9 4289.7 4292.6 4302.2 1418.9 1698.1 1752.7 1754.5 1775.2 881.2 941.8 944.5 1021.8 1027.7 17010.3 19696.5 19797.5 19875.4 19889.6 795.1 845.3 877.8 909.0 943.6 7481.3 10687.8 10698.0 10734.4 10737.8 727347.0 744040.0 744259.0 767906.0 769794.0 116441.0 120880.0 121287.4 121883.0 122236.0 1162.4 1170.0 1179.0 1184.4 1230.5 18786.1 18853.8 18912.3 19011.7 19047.6 51203.7 51600.5 51728.6 51781.7 52636.5 70275.0 70971.6 71231.9 72797.6 75052.6 7984.9 9665.4 9684.8 9751.7 9775.6 17873.6 19738.8 19882.8 20209.3 20516.9 15225.1 15474.0 15846.9 15876.6 16109.7 15009.0 15433.8 15455.6 15466.4 15705.5 11748.9 15763.8 15789.9 16263.5 16325.6 9594.0 9678.6 9732.6 9755.7 9761.7 15183.7 15706.2 15841.2 15845.0 15864.8 14:54:58 INFO - 2015-11-24 14:54:58,597 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,597 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5717.96 Median:6258.64 stddev:2972.85 (47.5%) stddev-sans-first:2964.87 14:54:58 INFO - 2015-11-24 14:54:58,598 DEBUG : BROWSER_OUTPUT: Values: 1574.2 1580.1 1622.9 1904.5 1912.7 7005.6 7797.0 7800.5 8250.1 8378.8 8164.4 8209.9 8256.4 8270.9 8280.1 2024.8 2329.0 2348.5 2349.0 2351.7 2127.8 2162.3 2168.6 2341.7 2394.5 2292.8 2340.5 2341.4 2344.5 2349.3 2099.7 2317.8 2352.4 2354.8 2355.3 2074.1 2094.2 2151.5 2159.4 2160.7 8074.2 8197.1 8201.7 8203.6 8205.6 5106.3 5158.5 5158.5 5192.0 5193.5 3420.3 3496.4 3535.6 3544.1 3547.0 1022.1 1039.8 1044.5 1051.5 1068.8 10859.9 10875.5 10883.8 10896.1 10909.6 4581.3 4582.9 4666.8 4675.8 4682.5 7835.6 8201.1 9543.4 9585.4 9588.9 5141.4 5177.4 5180.6 5189.6 5194.8 4690.3 4692.9 4726.9 4727.8 4730.6 3239.3 3733.3 3830.7 3847.2 3864.1 1246.8 1263.6 1265.6 1270.8 1271.0 1343.6 1364.8 1385.5 1392.3 1396.7 7647.2 7817.8 7820.0 7825.3 7844.9 490.8 504.4 506.7 508.0 508.9 5669.9 5767.9 6123.0 6193.4 6199.3 9183.2 9791.4 9867.0 9887.8 9931.7 9437.7 9653.6 9759.0 9860.0 9929.2 7811.1 7942.6 7947.6 7950.4 7953.2 7574.5 7717.2 7772.9 7773.8 7781.1 8700.9 8924.0 8957.1 9023.5 9069.1 9008.0 9322.9 9385.2 9435.6 9473.4 6317.9 7236.4 7269.2 7295.3 7347.7 7870.0 7923.0 7931.8 7941.0 7943.8 7287.2 7352.5 7360.4 7505.7 7527.0 7241.1 7264.8 7358.3 7382.9 7384.7 6956.5 7283.2 7293.7 7304.3 7338.0 6163.8 6782.3 6816.8 6823.6 6831.1 6747.1 6850.8 6865.0 6892.3 6900.1 14:54:58 INFO - 2015-11-24 14:54:58,598 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,598 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5992.75 Median:6857.99 stddev:1931.23 (28.2%) stddev-sans-first:1888.34 14:54:58 INFO - 2015-11-24 14:54:58,598 DEBUG : BROWSER_OUTPUT: Values: 273.5 330.2 331.7 334.6 334.7 6855.4 6881.3 6892.6 7003.1 7052.9 6900.5 6911.7 6913.7 6920.4 6922.9 4877.6 5028.6 5049.1 5049.7 5053.8 5029.6 5041.1 5046.5 5061.8 5075.3 4975.6 4977.6 4978.4 4981.6 4990.4 4741.8 4825.5 4870.6 4982.3 4998.5 4221.5 4247.5 4271.4 4288.2 4307.7 6563.2 6579.8 6605.1 6611.3 6612.5 5594.2 5681.8 5854.6 5881.5 6013.9 7235.6 7249.8 7365.4 7368.9 7385.9 4816.8 4816.9 4821.9 4826.5 4830.7 7243.6 7276.2 7508.4 7804.4 7806.3 4713.0 4723.1 4724.6 4725.7 4735.6 4783.9 4790.7 4809.0 4810.0 4817.9 5755.6 5762.8 5768.9 5771.4 5773.7 7144.9 7251.9 7320.2 7335.2 7338.6 1653.3 1684.6 1686.5 1686.7 1686.9 1053.5 1061.7 1072.2 1081.7 1083.1 6860.6 6867.4 6873.2 6881.6 6891.3 7627.1 7630.0 7639.2 7648.8 7648.8 6703.1 6834.8 6838.2 6839.7 6965.7 3922.0 4021.5 4022.1 4069.7 4106.4 6310.9 7860.1 7874.9 8054.1 8082.9 8050.8 8059.3 8068.6 8081.2 8082.9 6742.0 7805.2 7898.8 8041.6 8050.4 7442.5 7759.1 7777.0 7780.9 7781.6 6564.7 7412.1 7548.4 7624.7 7634.4 7104.5 7432.5 8019.7 8025.9 8033.1 4711.8 4760.9 4770.0 4773.9 4778.9 5828.9 7378.3 7422.0 7681.6 7713.0 7393.2 7400.7 7417.4 7426.5 7433.5 7371.1 7395.4 7408.2 7419.3 7419.7 7048.9 7262.5 7270.5 7277.7 7279.3 7426.0 7433.6 7437.7 7450.6 7451.7 6490.4 6729.9 7046.0 7214.7 7282.0 14:54:58 INFO - 2015-11-24 14:54:58,599 DEBUG : BROWSER_OUTPUT: 14:54:58 INFO - 2015-11-24 14:54:58,599 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18932.34 Median:50752.87 stddev:26746.90 (52.7%) stddev-sans-first:26787.03 14:54:58 INFO - 2015-11-24 14:54:58,600 DEBUG : BROWSER_OUTPUT: Values: 734.7 749.2 750.2 789.6 836.8 13401.9 14014.6 14546.2 14918.6 14923.3 12799.2 13805.4 13933.0 13939.4 13951.4 714.5 943.4 962.1 963.3 965.0 950.2 954.4 963.2 968.5 968.8 772.7 783.7 841.9 1014.8 1016.9 774.7 983.5 1021.9 1023.4 1027.3 742.1 742.8 743.3 744.2 744.6 14547.6 15033.8 15063.8 15097.3 15120.2 12684.2 12724.3 12866.5 13188.4 13551.1 10385.7 10407.3 10536.8 10750.1 11023.1 3594.1 3619.0 3634.0 3643.3 3689.0 64423.4 81724.6 81940.6 81953.0 82138.2 9937.2 10125.7 10278.2 10403.2 10788.7 17760.5 17917.9 22748.0 23037.0 23040.0 7326.5 7485.1 7617.8 7642.8 7772.7 3814.3 3838.1 3845.1 3915.3 4034.2 3459.6 3500.5 3501.1 3502.7 3508.1 596.0 657.5 659.6 666.2 673.0 468.8 481.7 489.3 515.0 532.1 8307.1 8558.6 8580.8 8655.2 8743.9 524.3 525.6 550.8 607.5 639.3 3773.5 3970.9 4038.4 4087.5 4234.2 91161.5 91866.0 92017.0 92462.0 92924.0 77474.7 77819.6 79163.2 86887.6 87347.0 73155.0 74587.6 78187.2 79244.6 80059.2 8925.8 8972.8 9047.7 9108.3 9211.3 50696.2 50809.5 53213.0 53564.7 55617.0 74601.6 74663.6 75672.6 77061.8 78390.6 11004.3 11063.9 11159.4 11185.0 11801.6 12019.9 12046.3 12115.3 12150.9 12554.7 11764.5 11852.8 11863.5 11962.8 12035.8 11914.3 11929.2 11957.9 11981.2 12067.0 11471.7 11715.5 11760.7 11791.7 11874.0 9456.5 9647.5 10001.3 10008.2 10179.6 8033.8 9783.3 9822.6 9866.8 9963.8 14:54:58 INFO - 2015-11-24 14:54:58,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:54:58 INFO - 2015-11-24 14:54:58,600 DEBUG : BROWSER_OUTPUT: 14:54:59 INFO - 2015-11-24 14:54:59,014 INFO : Browser exited with error code: 0 14:54:59 INFO - 2015-11-24 14:54:59,039 INFO : Completed test dromaeo_css (00:18:34) 14:54:59 INFO - 2015-11-24 14:54:59,039 INFO : Starting test kraken 14:54:59 INFO - 2015-11-24 14:54:59,039 DEBUG : operating with platform_type : mac_ 14:54:59 INFO - 2015-11-24 14:54:59,040 INFO : Initialising browser for kraken test... 14:54:59 INFO - 2015-11-24 14:54:59,052 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpOe6wjZ/profile http://localhost:57267/getInfo.html 14:55:01 INFO - 2015-11-24 14:55:01,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:55:01 INFO - 2015-11-24 14:55:01,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:55:01 INFO - 2015-11-24 14:55:01,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:55:01 INFO - 2015-11-24 14:55:01,059 DEBUG : BROWSER_OUTPUT: __metrics 14:55:01 INFO - 2015-11-24 14:55:01,068 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:55:01 INFO - 2015-11-24 14:55:01,710 INFO : Browser initialized. 14:55:01 INFO - 2015-11-24 14:55:01,710 INFO : Running cycle 1/1 for kraken test... 14:55:01 INFO - 2015-11-24 14:55:01,710 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpOe6wjZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:55:13 INFO - 2015-11-24 14:55:13,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 225079296 14:55:13 INFO - 2015-11-24 14:55:13,619 DEBUG : BROWSER_OUTPUT: 14:55:16 INFO - 2015-11-24 14:55:16,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:16 INFO - 2015-11-24 14:55:16,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 275050496 14:55:16 INFO - 2015-11-24 14:55:16,733 DEBUG : BROWSER_OUTPUT: 14:55:19 INFO - 2015-11-24 14:55:19,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-dft) 14:55:20 INFO - 2015-11-24 14:55:20,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 290611200 14:55:20 INFO - 2015-11-24 14:55:20,063 DEBUG : BROWSER_OUTPUT: 14:55:23 INFO - 2015-11-24 14:55:23,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-fft) 14:55:23 INFO - 2015-11-24 14:55:23,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 279482368 14:55:23 INFO - 2015-11-24 14:55:23,863 DEBUG : BROWSER_OUTPUT: 14:55:25 INFO - 2015-11-24 14:55:25,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-oscillator) 14:55:26 INFO - 2015-11-24 14:55:26,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 281812992 14:55:26 INFO - 2015-11-24 14:55:26,425 DEBUG : BROWSER_OUTPUT: 14:55:28 INFO - 2015-11-24 14:55:28,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:29 INFO - 2015-11-24 14:55:29,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 282083328 14:55:29 INFO - 2015-11-24 14:55:29,200 DEBUG : BROWSER_OUTPUT: 14:55:31 INFO - 2015-11-24 14:55:31,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:32 INFO - 2015-11-24 14:55:32,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 283553792 14:55:32 INFO - 2015-11-24 14:55:32,493 DEBUG : BROWSER_OUTPUT: 14:55:35 INFO - 2015-11-24 14:55:35,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:35 INFO - 2015-11-24 14:55:35,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 283758592 14:55:35 INFO - 2015-11-24 14:55:35,865 DEBUG : BROWSER_OUTPUT: 14:55:38 INFO - 2015-11-24 14:55:38,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57267/tests/kraken/driver.html?testName=json-parse-financial) 14:55:39 INFO - 2015-11-24 14:55:39,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 284237824 14:55:39 INFO - 2015-11-24 14:55:39,335 DEBUG : BROWSER_OUTPUT: 14:55:40 INFO - 2015-11-24 14:55:40,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:41 INFO - 2015-11-24 14:55:41,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 317931520 14:55:41 INFO - 2015-11-24 14:55:41,429 DEBUG : BROWSER_OUTPUT: 14:55:43 INFO - 2015-11-24 14:55:43,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:43 INFO - 2015-11-24 14:55:43,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 319332352 14:55:43 INFO - 2015-11-24 14:55:43,951 DEBUG : BROWSER_OUTPUT: 14:55:46 INFO - 2015-11-24 14:55:46,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:46 INFO - 2015-11-24 14:55:46,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 324272128 14:55:46 INFO - 2015-11-24 14:55:46,594 DEBUG : BROWSER_OUTPUT: 14:55:49 INFO - 2015-11-24 14:55:49,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:49 INFO - 2015-11-24 14:55:49,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 325844992 14:55:49 INFO - 2015-11-24 14:55:49,747 DEBUG : BROWSER_OUTPUT: 14:55:52 INFO - 2015-11-24 14:55:52,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:52 INFO - 2015-11-24 14:55:52,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 325099520 14:55:52 INFO - 2015-11-24 14:55:52,967 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57267/tests/kraken/driver.html?testName=ai-astar) 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 384270336 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;109;110;108;99;108;109;103 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;120;143;177;103;166;166;144;178;141 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;179;179;182;185;181;185;187;186;179 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;71;79;72;56;57;58;76;92;89 14:55:54 INFO - 2015-11-24 14:55:54,912 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;84;117;75;75;76;138;110;109;142 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;88;87;86;87;86;85;86;86;86 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;92;94;93;93;94;91;94;93;94;93 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;88;101;113;127;134;84;84;84;84 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;53;54;53;55;53;63;53;54 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;63;63;62;70;96;96;92;67 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;82;82;82;83;82;80;83;84 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;123;124;121;131;119;125;123;127;137 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;166;115;158;169;164;144;139;133;134 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;63;64;64;65;64;65;65;65;64 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1070 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:55:54 INFO - 2015-11-24 14:55:54,913 DEBUG : BROWSER_OUTPUT: __startTimestamp1448405754905__endTimestamp 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:3.54 (3.2%) stddev-sans-first:3.73 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 109.0 110.0 108.0 99.0 108.0 109.0 103.0 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:158.00 stddev:24.23 (15.3%) stddev-sans-first:25.70 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: Values: 150.0 120.0 143.0 177.0 103.0 166.0 166.0 144.0 178.0 141.0 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.70 Median:184.50 stddev:3.09 (1.7%) stddev-sans-first:3.24 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: Values: 184.0 179.0 179.0 182.0 185.0 181.0 185.0 187.0 186.0 179.0 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.40 Median:74.00 stddev:12.88 (17.4%) stddev-sans-first:13.38 14:55:54 INFO - 2015-11-24 14:55:54,914 DEBUG : BROWSER_OUTPUT: Values: 64.0 71.0 79.0 72.0 56.0 57.0 58.0 76.0 92.0 89.0 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.90 Median:75.00 stddev:25.91 (34.5%) stddev-sans-first:26.66 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 117.0 75.0 75.0 76.0 138.0 110.0 109.0 142.0 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 87.0 86.0 87.0 86.0 85.0 86.0 86.0 86.0 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.50 stddev:0.99 (1.1%) stddev-sans-first:0.97 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 93.0 93.0 94.0 91.0 94.0 93.0 94.0 93.0 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:98.40 Median:84.00 stddev:19.50 (23.2%) stddev-sans-first:20.07 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 101.0 113.0 127.0 134.0 84.0 84.0 84.0 84.0 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,915 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.03 (5.6%) stddev-sans-first:3.22 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 53.0 54.0 53.0 55.0 53.0 63.0 53.0 54.0 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:68.50 stddev:15.00 (21.9%) stddev-sans-first:15.35 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 63.0 62.0 70.0 96.0 96.0 92.0 67.0 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 82.0 82.0 82.0 83.0 82.0 80.0 83.0 84.0 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:5.21 (4.2%) stddev-sans-first:5.50 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: Values: 124.0 123.0 124.0 121.0 131.0 119.0 125.0 123.0 127.0 137.0 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:155.50 stddev:17.48 (11.2%) stddev-sans-first:18.43 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: Values: 153.0 166.0 115.0 158.0 169.0 164.0 144.0 139.0 133.0 134.0 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: 14:55:54 INFO - 2015-11-24 14:55:54,916 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:55:54 INFO - 2015-11-24 14:55:54,917 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 14:55:54 INFO - 2015-11-24 14:55:54,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:55:54 INFO - 2015-11-24 14:55:54,917 DEBUG : BROWSER_OUTPUT: 14:55:55 INFO - 2015-11-24 14:55:55,571 INFO : Browser exited with error code: 0 14:55:55 INFO - 2015-11-24 14:55:55,618 INFO : Completed test kraken (00:00:56) 14:55:55 INFO - 2015-11-24 14:55:55,618 INFO : Starting test v8_7 14:55:55 INFO - 2015-11-24 14:55:55,618 DEBUG : operating with platform_type : mac_ 14:55:55 INFO - 2015-11-24 14:55:55,619 INFO : Initialising browser for v8_7 test... 14:55:55 INFO - 2015-11-24 14:55:55,631 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmptUPBi6/profile http://localhost:57267/getInfo.html 14:55:57 INFO - 2015-11-24 14:55:57,669 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:55:57 INFO - 2015-11-24 14:55:57,669 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:55:57 INFO - 2015-11-24 14:55:57,669 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:55:57 INFO - 2015-11-24 14:55:57,669 DEBUG : BROWSER_OUTPUT: __metrics 14:55:57 INFO - 2015-11-24 14:55:57,679 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: console.error: 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: Stack: 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 14:55:57 INFO - 2015-11-24 14:55:57,941 DEBUG : BROWSER_OUTPUT: 14:55:58 INFO - 2015-11-24 14:55:58,345 INFO : Browser initialized. 14:55:58 INFO - 2015-11-24 14:55:58,345 INFO : Running cycle 1/1 for v8_7 test... 14:55:58 INFO - 2015-11-24 14:55:58,345 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmptUPBi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:56:10 INFO - 2015-11-24 14:56:10,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 227110912 14:56:10 INFO - 2015-11-24 14:56:10,152 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57267/tests/v8_7/run.html (next: http://localhost:57267/tests/v8_7/run.html) 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 690683904 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: |0;Richards;175.07002801120447 14:56:31 INFO - 2015-11-24 14:56:31,925 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.926939169617 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.7254735651682 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4766.666666666667 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1722.8915662650602 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |6;Boyer;12721.518987341773 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |8;Splay;608.5106382978723 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4699.530516431925 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: __startTimestamp1448405791919__endTimestamp 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,926 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:175.07 Median:175.07 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: Values: 175.1 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.93 Median:160.93 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: Values: 160.9 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: Values: 282.7 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4766.67 Median:4766.67 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: Values: 4766.7 14:56:31 INFO - 2015-11-24 14:56:31,927 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1722.89 Median:1722.89 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: Values: 1722.9 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: Values: 788.6 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12721.52 Median:12721.52 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: Values: 12721.5 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: Values: 26763.2 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,928 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.51 Median:608.51 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: Values: 608.5 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4699.53 Median:4699.53 stddev:0.00 (0.0%) 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: Values: 4699.5 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:56:31 INFO - 2015-11-24 14:56:31,929 DEBUG : BROWSER_OUTPUT: 14:56:32 INFO - 2015-11-24 14:56:32,574 INFO : Browser exited with error code: 0 14:56:32 INFO - 2015-11-24 14:56:32,592 INFO : Completed test v8_7 (00:00:36) 14:56:32 INFO - 2015-11-24 14:56:32,937 INFO : Completed test suite (00:20:08) 14:56:32 INFO - 2015-11-24 14:56:32,937 DEBUG : Working with test: dromaeo_css 14:56:32 INFO - 2015-11-24 14:56:32,937 DEBUG : Generating results file: dromaeo_css 14:56:32 INFO - 2015-11-24 14:56:32,938 DEBUG : Working with test: kraken 14:56:32 INFO - 2015-11-24 14:56:32,938 DEBUG : Generating results file: kraken 14:56:32 INFO - 2015-11-24 14:56:32,938 INFO : javascript benchmark 14:56:32 INFO - 2015-11-24 14:56:32,939 DEBUG : Working with test: v8_7 14:56:32 INFO - 2015-11-24 14:56:32,939 DEBUG : Generating results file: v8_7 14:56:32 INFO - 2015-11-24 14:56:32,939 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:56:33 INFO - 2015-11-24 14:56:33,455 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 14:56:33 INFO - 2015-11-24 14:56:33,455 DEBUG : process_Request line: dromaeo_css 7611.03 graph.html#tests=[[72,64,59]] 14:56:33 INFO - 2015-11-24 14:56:33,455 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:56:33 INFO - 2015-11-24 14:56:33,478 DEBUG : process_Request line: kraken 1436.10 graph.html#tests=[[232,64,59]] 14:56:33 INFO - 2015-11-24 14:56:33,478 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:56:33 INFO - 2015-11-24 14:56:33,500 DEBUG : process_Request line: v8_7 20386.30 graph.html#tests=[[230,64,59]] 14:56:33 INFO - 2015-11-24 14:56:33,501 INFO : javascript benchmark 14:56:33 INFO - 2015-11-24 14:56:33,503 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3073.830939298339, 3366.4950257461364, 3413.7781044232124, 3427.8628854845792, 3439.7076248518883, 5470.589705772073, 5628.718564071795, 5631.662100273976, 5691.459311365424, 5728.598998070137, 5591.881623675261, 5609.214709940612, 5675.6878371689545, 5788.363280039192, 5804.767809287623, 5064.620153488485, 5067.721275329855, 5117.437081920985, 5157.664751791141, 5204.115300398922, 5195.19474481456, 5197.558207552363, 5202.985417843522, 5230.189320655304, 5265.657732247391, 5049.368828896388, 5131.794728210886, 5151.201563757623, 5151.304573882516, 5177.430482646943, 4425.402570652985, 5092.26162206478, 5155.53600175986, 5162.406323272834, 5167.3282473278605, 5082.974585127087, 5109.4379618241965, 5117.948820511784, 5148.176291793295, 5162.483751624845, 5638.887222255573, 5648.519875810561, 5652.954203472371, 5664.830055098354, 5668.121441176624, 6098.756049758004, 6151.384861513858, 6154.938450615526, 6166.599171053867, 6175.814725558195, 6290.905636415458, 6297.559170858041, 6320.178376811031, 6330.493560515148, 6332.936670633281, 5748.626339287933, 5860.179574859523, 5860.970695146497, 5863.208466856962, 5864.912026319608, 5963.493103086286, 6047.9395206047375, 6126.969365153235, 6267.122602835607, 6284.937150628435, 5264.52619264268, 6050.6974651267265, 6071.119687645267, 6076.939230607726, 6077.392260773887, 6219.0, 6293.874122517524, 6304.432601065926, 6304.905426418607, 6305.4009869062365, 5967.6121052131475, 6101.328853826076, 6104.267487901391, 6217.96891015542, 6223.408776166257, 6125.215553761287, 6139.785107521216, 6142.095950255435, 6142.529470848956, 6148.1085242639565, 4849.0, 4911.312416261726, 4923.113839508923, 4927.211646136601, 4933.555979961749, 4358.4769827620885, 4412.889677758082, 4415.227335216325, 4425.535318791545, 4449.755263460541, 5675.1770993205755, 5699.487046165865, 5706.71466426677, 5710.029295019856, 5712.028955077647, 6075.635461872302, 6145.432914606836, 6149.692515374213, 6283.497320214372, 6296.622202667854, 5624.353199382042, 5630.268065151504, 5637.26715526987, 5640.379558248589, 5648.124540696199, 5411.161270003156, 5415.729213539307, 5416.891662166735, 5425.593080518976, 5461.863453413696, 6283.277423096311, 6295.527835412362, 6317.778877739257, 6326.272478664829, 6327.335629758901, 6080.726367313393, 6166.136740856194, 6305.180326557518, 6317.336679648571, 6331.461825744863, 6188.752449901954, 6277.372262773686, 6281.466075383643, 6282.2147231596055, 6300.369963003846, 6080.915733170807, 6110.40687992437, 6135.417135372132, 6142.464383904024, 6156.415140561639, 6244.562880598496, 6259.0, 6259.65571893532, 6264.404881536247, 6267.373262673696, 5841.561882858888, 5900.852478688067, 5978.0, 6022.759089636365, 6031.728572214349, 5950.702464876826, 6003.159557661844, 6017.578769486094, 6026.397360263939, 6070.848228794315, 5862.325832529314, 5903.026000710007, 5936.614120082181, 5954.434328738763, 5957.314908785545, 5751.0, 5932.525397968066, 5953.017752070859, 6096.0855871619615, 6097.359777223505, 5873.765049397976, 5952.8809423812145, 5954.523638108854, 5967.91048134287, 5982.910256346071], "unit": "ms", "name": "dojo.html", "value": 5658.1223660014975}, {"lowerIsBetter": false, "replicates": [529.7060131626947, 546.3089192171901, 585.2508788750399, 602.6655206360474, 630.2374127305959, 32319.0, 32749.345013099723, 32807.343853122955, 32815.50776738351, 32928.67071329289, 33598.32803343931, 33962.81130160445, 34008.14979625511, 42966.35550466745, 43451.0, 9769.658061967815, 9886.258530610197, 9899.90100098997, 9936.503174841266, 9948.60205591779, 9498.002709715483, 9562.569684364185, 9575.0, 9580.185684216814, 9629.807403851919, 8910.33172512061, 8969.058248883872, 8982.146696063863, 11947.522099116024, 12093.03255739543, 11860.703482412922, 11959.40202989847, 11966.880331196751, 11972.461239244254, 11984.161108722394, 8876.644934202624, 11736.471858766376, 11894.940525297405, 11915.880841191563, 11924.046076313874, 32146.357072858413, 32364.0, 32496.512552311735, 32551.02346929596, 43066.56933430657, 3142.261568531393, 3172.0959526535057, 3177.2374630088843, 3216.2281052547455, 3778.5087938568086, 24318.78406079689, 28898.42203155925, 29069.85465072661, 29573.55639665407, 29621.45645900523, 2773.3066733316673, 2792.176307989148, 2849.7435230829324, 2877.208767588909, 2974.0631701014113, 468765.1234876485, 470994.32045436284, 471252.99999999657, 471390.0, 471550.0, 63773.40566485782, 63778.0, 63971.360286397474, 64361.35638643647, 69101.30898690948, 62030.0, 76326.61836690892, 77390.6130469344, 77418.6129069351, 77516.0, 16328.75506867398, 16488.422905198262, 16641.16794160287, 16642.417515386904, 16723.49829505117, 12573.245605263714, 12637.620871373874, 12637.620871373874, 12638.684032899067, 12775.61673149807, 22097.558048839255, 22161.22435714742, 22244.55510889773, 22247.22134725277, 22309.665355019686, 8606.31149508038, 8785.604647790864, 8823.0, 8831.498645230326, 8861.24679402245, 936.3726303376754, 980.7989362180735, 980.9950950245203, 1073.7798751255973, 1104.5747387255965, 29504.409911801642, 29812.10563683093, 29854.40291194164, 30526.38947221043, 30607.540886886716, 992.9982171847466, 1042.8331466965249, 1050.922804125762, 1109.389835590422, 1172.976540469186, 14983.625409364635, 15208.619784505254, 15347.309371078329, 15527.84472155264, 15570.221488925736, 444566.0, 532374.0, 537875.3106234444, 538218.308908453, 539430.0, 59414.811703765685, 59466.10800837991, 59590.0, 59622.40377596255, 59687.701561491915, 1460.5545308680742, 1473.2486431920013, 1483.770015647598, 1485.6508720450686, 1597.9920100399424, 29773.5533966995, 30167.698323016488, 30479.390412192075, 30501.694983050773, 31176.0, 54260.728696356266, 54640.18039729487, 54687.45312546983, 54708.72645636746, 54719.0, 393144.0, 394499.0, 395778.0, 396071.0, 396319.0, 28272.0, 28738.99413520517, 28829.56755648625, 31660.5250921241, 33833.49249761305, 42547.93630159147, 42805.35791963185, 43022.0, 44327.33508997303, 44457.99878010995, 35886.64113358833, 36077.189055223425, 36561.26877462489, 36579.45130823093, 36721.81639091788, 32448.513272301407, 35098.29803403969, 35694.82152589221, 35886.82056589805, 36212.0, 35686.929392118276, 36680.44979325259, 36925.446118308784, 36938.26123477462, 36940.63059369372, 30055.948041818432, 30397.392052159274, 32427.18932026718, 32510.699572016856, 33206.83396583002, 24234.39414014593, 24299.757002430455, 24553.75446245515, 24702.505949880542, 24814.88333024982], "unit": "ms", "name": "ext.html", "value": 19903.243515734943}, {"lowerIsBetter": false, "replicates": [359.06105534028524, 361.92037751694625, 362.9981850090749, 363.62728203591325, 363.91811842335477, 15772.684546309067, 16021.0, 19108.331208407708, 19727.0, 20478.488037799063, 17041.06274154921, 17472.21375038123, 17531.64936701265, 18426.44720658379, 20862.269820556285, 5800.071988481844, 5837.066069428903, 5909.468147866691, 5919.052951527757, 5920.023196172627, 4213.726107802999, 4335.826566937319, 4340.392345071693, 5863.120531920204, 5931.317898441691, 6315.273743519485, 6428.389303016229, 6474.028895665664, 6475.676216189196, 6477.578957367756, 6297.181366422359, 6528.967355163241, 6529.967350163242, 6532.7713530026695, 6534.901976470333, 5512.944870551283, 5632.267805185341, 5640.802571910004, 5645.633033852787, 5646.745896434671, 24866.50266994668, 24909.62635560468, 24954.50090998188, 25099.62350564743, 25472.363190920376, 2081.323569839808, 2083.447886310129, 2086.968695469569, 2103.9425274194587, 2125.4686328417897, 9186.356955013152, 14960.952733308673, 15047.021943573633, 15300.08199508033, 15554.688906221925, 1700.3113738935751, 1740.7649967254386, 1746.9912650436793, 1767.823217678222, 1774.8313910178513, 82340.0, 98000.50999745027, 100980.0, 101805.9819401804, 102573.48713256385, 8910.732678019669, 10904.61833835812, 10931.945340273407, 10992.670219893416, 11005.944970275097, 13147.60557183286, 13168.60494185176, 13192.670183245304, 13195.274259915797, 13203.40584673692, 8061.355091592776, 8234.176582341717, 8250.422470427133, 8331.250187483156, 8338.99932008163, 7971.043474783063, 8341.499510029418, 8354.916450835535, 8363.749087527383, 8434.367422443342, 3736.5702944161226, 4255.87232383029, 4289.699721019561, 4292.59220374064, 4302.225599392077, 1418.9219592922489, 1698.100006996294, 1752.7195648696402, 1754.5438186071713, 1775.1568005197687, 881.2113158722907, 941.773974246176, 944.5182956691999, 1021.8211812932707, 1027.7204879924393, 17010.319587216374, 19696.507587310432, 19797.505062373555, 19875.403737887886, 19889.60220795576, 795.1134485049245, 845.2688424512752, 877.7981064355106, 908.9636414543477, 943.5895385507326, 7481.289277518627, 10687.78624427507, 10698.0, 10734.409607471507, 10737.83893241602, 727347.0, 744040.0, 744259.0, 767906.0, 769794.0, 116441.0, 120880.0, 121287.39356303163, 121883.0, 122236.0, 1162.3897453836635, 1169.9532018719156, 1178.9941050294694, 1184.4373922386796, 1230.5323976888903, 18786.06069696537, 18853.811461885205, 18912.338068167548, 19011.714824277922, 19047.619047619246, 51203.743981279855, 51600.48399515957, 51728.63763855337, 51781.7410912943, 52636.47363526316, 70275.0, 70971.64514177396, 71231.93152102618, 72797.6360118196, 75052.62473687815, 7984.880226796487, 9665.371750836173, 9684.75788105303, 9751.707448776548, 9775.608975640895, 17873.553161171076, 19738.80261197427, 19882.801171988674, 20209.292674756314, 20516.897415512827, 15225.086494810346, 15474.0, 15846.920765396098, 15876.60308492297, 16109.677806443571, 15009.024413413093, 15433.84566154324, 15455.61360965985, 15466.381344746083, 15705.450309239122, 11748.88251117478, 15763.842361576697, 15789.921050394674, 16263.512094637179, 16325.59186020359, 9593.952030239805, 9678.564464598969, 9732.610695572097, 9755.658551950648, 9761.707148785548, 15183.696326073195, 15706.21468926572, 15841.207939603204, 15844.970076945423, 15864.762028569812], "unit": "ms", "name": "jquery.html", "value": 9962.882099668559}, {"lowerIsBetter": false, "replicates": [1574.2050264616366, 1580.0835515401068, 1622.9369762805366, 1904.523869032742, 1912.6652835753741, 7005.579665220091, 7797.0, 7800.531968081919, 8250.133735957728, 8378.832423351529, 8164.38767092469, 8209.876851847212, 8256.380771442136, 8270.875936860952, 8280.130586288444, 2024.7570291565032, 2328.976710232897, 2348.5068135691527, 2348.9765102349015, 2351.706036745407, 2127.819135373495, 2162.264829957814, 2168.56628674265, 2341.730700969393, 2394.473215892501, 2292.805111565519, 2340.5435939991708, 2341.4029422497324, 2344.542814151241, 2349.34218418843, 2099.737532808399, 2317.7566355532595, 2352.400137964808, 2354.846934949223, 2355.281639100074, 2074.0666699985068, 2094.172801743318, 2151.5051538146313, 2159.3845753960045, 2160.6758986152045, 8074.152214017561, 8197.139300373434, 8201.671933122727, 8203.58982050895, 8205.58972051401, 5106.285120083191, 5158.484151584849, 5158.509941555546, 5192.013517431714, 5193.532582067594, 3420.26464310172, 3496.3531746626954, 3535.5934067582302, 3544.078539579702, 3547.0068380853404, 1022.1465076660998, 1039.7816458543714, 1044.4725413666126, 1051.526812934175, 1068.8076146293663, 10859.914008599157, 10875.510602022929, 10883.83674244887, 10896.128309735202, 10909.618163364323, 4581.289900065495, 4582.862514124515, 4666.789994450258, 4675.812967481331, 4682.484926658065, 7835.6473958671995, 8201.13888041747, 9543.42739435636, 9585.424874507551, 9588.904110958802, 5141.408737995103, 5177.430482646906, 5180.611454140954, 5189.610779191576, 5194.844154675366, 4690.296455531698, 4692.882677933011, 4726.905461890743, 4727.787249573777, 4730.645201609893, 3239.2549713566013, 3733.3466643337306, 3830.6935445164877, 3847.1920896612023, 3864.091938394475, 1246.8067449545154, 1263.633546271571, 1265.5570550307318, 1270.8093785932185, 1270.9618711438673, 1343.596920923719, 1364.836219653628, 1385.49429458247, 1392.3455975691409, 1396.685745707228, 7647.197044310267, 7817.843643127106, 7820.0, 7825.256600622932, 7844.882326765103, 490.83557008402585, 504.44511037858064, 506.6782593053438, 507.9796808127634, 508.9083964886356, 5669.943300567024, 5767.942320576824, 6122.969385153046, 6193.411625895533, 6199.3490683477585, 9183.173514383738, 9791.363561368631, 9866.963968783319, 9887.752806179758, 9931.702048938543, 9437.716868493957, 9653.613855445845, 9758.95120524407, 9859.950700246596, 9929.2056635469, 7811.140774514799, 7942.6425810838655, 7947.602619868983, 7950.403719721044, 7953.204679532117, 7574.545527268381, 7717.1896950819355, 7772.92227077722, 7773.844523109619, 7781.06627204739, 8700.91299087001, 8924.0, 8957.14907083826, 9023.503707296162, 9069.138431848964, 9007.954960225157, 9322.906770932204, 9385.15533601979, 9435.622575096919, 9473.384230025027, 6317.936820631735, 7236.421086312977, 7269.236730143259, 7295.306945840137, 7347.70609175627, 7870.0, 7923.049234091945, 7931.762047138595, 7941.00737407824, 7943.761687149395, 7287.1984081752025, 7352.485326027127, 7360.411167106511, 7505.737299194502, 7526.983857179211, 7241.131064272321, 7264.818379540554, 7358.264173582813, 7382.889256661262, 7384.741534046282, 6956.478264130109, 7283.198848126808, 7293.671784769592, 7304.306090921354, 7338.0, 6163.8150855474405, 6782.321767823179, 6816.829579260359, 6823.624700641512, 6831.077804496329, 6747.089142965833, 6850.794476165723, 6865.0, 6892.276310987475, 6900.068490753884], "unit": "ms", "name": "mootools.html", "value": 4615.71882834728}, {"lowerIsBetter": false, "replicates": [273.4708339363332, 330.23715217846774, 331.69981167043835, 334.6108783287327, 334.7071312601474, 6855.41728953039, 6881.277465866081, 6892.620905850183, 7003.089598352207, 7052.942058691199, 6900.482463815209, 6911.654417279141, 6913.723451061964, 6920.377166055054, 6922.861542769142, 4877.561019508244, 5028.622853286, 5049.116404629193, 5049.722265275408, 5053.797848086081, 5029.647924645276, 5041.092603331417, 5046.470120637336, 5061.848144555651, 5075.340205773245, 4975.577075948549, 4977.576905962997, 4978.402591688984, 4981.626378021663, 4990.401151861782, 4741.762911854428, 4825.5174482551465, 4870.561649451531, 4982.252662100677, 4998.450170481262, 4221.493420789494, 4247.469066366704, 4271.380649805792, 4288.16380805743, 4307.655387568987, 6563.212414510242, 6579.769708060243, 6605.108310378086, 6611.338866113399, 6612.537122401433, 5594.2447769551, 5681.772729090872, 5854.619449735754, 5881.47066763989, 6013.939860601426, 7235.638218089074, 7249.78250652476, 7365.373943214833, 7368.926310736878, 7385.929040289182, 4816.8073277069225, 4816.927746083811, 4821.855344339676, 4826.4690884003085, 4830.73430961297, 7243.5653860768525, 7276.235995220479, 7508.361789247921, 7804.3756499479905, 7806.282617824069, 4713.0, 4723.055388922229, 4724.645651576146, 4725.692829966041, 4735.59747421473, 4783.856484305476, 4790.712557246577, 4808.975955120202, 4810.0, 4817.927731084036, 5755.625884317506, 5762.798302059407, 5768.913466298009, 5771.394003629558, 5773.653580785166, 7144.879519568438, 7251.891221631679, 7320.1581818090535, 7335.193128755833, 7338.5596864187255, 1653.330401187521, 1684.5956970327034, 1686.5024817678814, 1686.7216909209842, 1686.9325226990784, 1053.4732633683159, 1061.6655753437642, 1072.2494254022215, 1081.6538707613488, 1083.1389045708681, 6860.5540639858245, 6867.381935625718, 6873.20958089816, 6881.552699074544, 6891.27641597635, 7627.084749830056, 7630.008098947102, 7639.159692433828, 7648.770536883902, 7648.847023059508, 6703.095082163943, 6834.829129271709, 6838.213605435439, 6839.692213850389, 6965.651717414109, 3921.9607803922167, 4021.4571032910767, 4022.054817117975, 4069.694772892045, 4106.445629839993, 6310.9368906311265, 7860.135385107634, 7874.881876771853, 8054.114047454776, 8082.878756818653, 8050.83898322042, 8059.314958228499, 8068.636911339004, 8081.151479094728, 8082.878756818653, 6741.954996975379, 7805.180456052146, 7898.763037108896, 8041.6381262843315, 8050.396220283385, 7442.516236444614, 7759.146493885555, 7777.0, 7780.92219077802, 7781.610919454118, 6564.704588293634, 7412.110546734426, 7548.433867459853, 7624.733134340271, 7634.427417943565, 7104.538205016657, 7432.479726419098, 8019.719309824128, 8025.879611805711, 8033.11635720082, 4711.835085772119, 4760.9047819042735, 4770.0, 4773.904521909473, 4778.856634300976, 5828.854278643068, 7378.335949764547, 7422.0, 7681.5775132366025, 7712.961435193012, 7393.223711510429, 7400.703971841066, 7417.443691723034, 7426.480146389917, 7433.516821406592, 7371.115466144097, 7395.371393431618, 7408.185099638928, 7419.29516695913, 7419.740309089156, 7048.894266586108, 7262.455315851226, 7270.491065625355, 7277.672504737194, 7279.344858962719, 7426.0, 7433.553986760811, 7437.665305061393, 7450.552966822008, 7451.701931922662, 6490.448311893542, 6729.865402692017, 7046.0, 7214.74748383804, 7282.0], "unit": "ms", "name": "prototype.html", "value": 5334.337188217594}, {"lowerIsBetter": false, "replicates": [734.7097896330949, 749.2208103572285, 750.1785544828415, 789.5578476053411, 836.8075342671185, 13401.92784577234, 14014.649633759162, 14546.199959002251, 14918.627034324147, 14923.328450219738, 12799.232046077219, 13805.37875795589, 13932.999999999975, 13939.442422303122, 13951.441942322295, 714.4605822603927, 943.4433684126365, 962.1052421248237, 963.2871674960548, 965.0012237334361, 950.2208189284789, 954.374884450686, 963.2149797914713, 968.4625033106623, 968.7674958010062, 772.7102336623766, 783.7452827830949, 841.869510225916, 1014.8173328800813, 1016.9389836609827, 774.7017398301638, 983.5475681186663, 1021.9284650074497, 1023.380854582974, 1027.250107421579, 742.1168809117133, 742.8031571633521, 743.275306576084, 744.1851172965594, 744.5904752386166, 14547.563573092824, 15033.774493382609, 15063.849361506464, 15097.3206205721, 15120.243987800566, 12684.175528590613, 12724.300163491005, 12866.549670761478, 13188.406521706545, 13551.051426400156, 10385.688429347132, 10407.33482642781, 10536.789264214673, 10750.139988800876, 11023.118150548016, 3594.137407022322, 3618.999499700301, 3634.036980200249, 3643.307771523402, 3688.963110368889, 64423.355766442204, 81724.59137704333, 81940.59029704814, 81953.0, 82138.17861821366, 9937.205023598095, 10125.746856328651, 10278.229132814919, 10403.21975851799, 10788.730281743019, 17760.467185984442, 17917.910410447865, 22747.97634106436, 23036.96333664989, 23040.0, 7326.523775954546, 7485.0643669541305, 7617.847643047219, 7642.821795788285, 7772.65023073963, 3814.294355544233, 3838.05967537955, 3845.0771814764257, 3915.275674000262, 4034.23349563582, 3459.6021457532706, 3500.4749287607065, 3501.089716673683, 3502.7022703070525, 3508.122969257686, 595.9642421454727, 657.4937298280392, 659.6108296105225, 666.2105405094978, 672.9764458243937, 468.81857718549065, 481.73745308806787, 489.29297165596086, 514.9974250128726, 532.1379365427954, 8307.08622051574, 8558.61486233121, 8580.785480362916, 8655.221030107321, 8743.868841967376, 524.2529395611239, 525.5637820608886, 550.840256325661, 607.5291648971994, 639.3478651775164, 3773.4905787718853, 3970.920581588352, 4038.394240863835, 4087.5094988600963, 4234.195502854448, 91161.54419227994, 91866.0, 92017.0, 92462.0, 92924.0, 77474.67575972617, 77819.61090194626, 79163.20836791674, 86887.56556217179, 87347.0, 73155.0, 74587.62706186435, 78187.21812781913, 79244.60377698074, 80059.19940800635, 8925.776855578662, 8972.775680608038, 9047.68333108338, 9108.271338293052, 9211.263098952202, 50696.23955640742, 50809.49434052733, 53213.0, 53564.73217633887, 55617.0, 74601.62699186469, 74663.62668186841, 75672.62163689146, 77061.84407234009, 78390.60804696169, 11004.284721493077, 11063.944680276869, 11159.38623375722, 11184.993350598485, 11801.645950621494, 12019.879801201876, 12046.337451439904, 12115.273083615011, 12150.939245303716, 12554.686132846751, 11764.470598823245, 11852.76294474123, 11863.525458981889, 11962.76074478523, 12035.819462708241, 11914.285142891455, 11929.164958452826, 11957.940210298893, 11981.221220620631, 12067.0, 11471.655850324503, 11715.472803723682, 11760.705982350168, 11791.705207369885, 11874.0, 9456.479893605918, 9647.469389183661, 10001.299779037436, 10008.249381296577, 10179.592816287266, 8033.758987230392, 9783.315167938175, 9822.607095716092, 9866.753331166778, 9963.750906227402], "unit": "ms", "name": "yui.html", "value": 7035.968868599804}], "name": "dromaeo_css", "value": 7611.033857673222}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 108.0, 99.0, 108.0, 109.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 143.0, 177.0, 103.0, 166.0, 166.0, 144.0, 178.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [184.0, 179.0, 179.0, 182.0, 185.0, 181.0, 185.0, 187.0, 186.0, 179.0], "unit": "ms", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 79.0, 72.0, 56.0, 57.0, 58.0, 76.0, 92.0, 89.0], "unit": "ms", "name": "audio-fft", "value": 71.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 117.0, 75.0, 75.0, 76.0, 138.0, 110.0, 109.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 100.9}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 87.0, 86.0, 87.0, 86.0, 85.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 93.0, 93.0, 94.0, 91.0, 94.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 101.0, 113.0, 127.0, 134.0, 84.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 98.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 53.0, 54.0, 53.0, 55.0, 53.0, 63.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 63.0, 63.0, 62.0, 70.0, 96.0, 96.0, 92.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 73.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 80.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 124.0, 121.0, 131.0, 119.0, 125.0, 123.0, 127.0, 137.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [153.0, 166.0, 115.0, 158.0, 169.0, 164.0, 144.0, 139.0, 133.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1436.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [175.07002801120447], "unit": "score", "name": "Richards", "value": 201.645024}, {"lowerIsBetter": false, "replicates": [160.926939169617], "unit": "score", "name": "DeltaBlue", "value": 410.85725199999996}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [4766.666666666667], "unit": "score", "name": "Decrypt", "value": 55.84216783216784}, {"lowerIsBetter": false, "replicates": [1722.8915662650602], "unit": "score", "name": "RayTrace", "value": 429.5041048951049}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12721.518987341773], "unit": "score", "name": "Boyer", "value": 52.38863383084579}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [608.5106382978723], "unit": "score", "name": "Splay", "value": 133.91877622377623}, {"lowerIsBetter": false, "replicates": [4699.530516431925], "unit": "score", "name": "NavierStokes", "value": 315.77622377622396}], "name": "v8_7", "value": 20386.30005535156}]} 14:56:33 INFO - RETURN: dromaeo_css: 7611.03 14:56:33 INFO - RETURN: kraken: 1436.10 14:56:33 INFO - RETURN: v8_7: 20386.30 14:56:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20386.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1436.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7611.03"}}} 14:56:33 INFO - Return code: 0 14:56:33 INFO - # TBPL SUCCESS # 14:56:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:56:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:56:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:56:33 INFO - 2015-11-24 14:56:33.612 screenresolution[1958:20384] starting screenresolution argv=screenresolution get 14:56:33 INFO - 2015-11-24 14:56:33.614 screenresolution[1958:20384] Display 0: 1600x1200x32@60 14:56:33 INFO - 2015-11-24 14:56:33.620 screenresolution[1959:20387] starting screenresolution argv=screenresolution list 14:56:33 INFO - Available Modes on Display 0 14:56:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:56:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:56:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:56:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:56:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:56:33 INFO - Intel Iris: 14:56:33 INFO - Chipset Model: Intel Iris 14:56:33 INFO - Type: GPU 14:56:33 INFO - Bus: Built-In 14:56:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:56:33 INFO - Vendor: Intel (0x8086) 14:56:33 INFO - Device ID: 0x0a2e 14:56:33 INFO - Revision ID: 0x0009 14:56:33 INFO - Displays: 14:56:33 INFO - Display: 14:56:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:56:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:56:33 INFO - Display Serial Number: 1600x1200 60 14:56:33 INFO - Main Display: Yes 14:56:33 INFO - Mirror: Off 14:56:33 INFO - Online: Yes 14:56:33 INFO - Rotation: Supported 14:56:33 INFO - Return code: 0 14:56:33 INFO - Running post-action listener: _resource_record_post_action 14:56:33 INFO - Running post-run listener: _resource_record_post_run 14:56:34 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 188416; Write bytes: 687415808; Read time: 5; Write time: 2269 14:56:34 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336947712; Write bytes: 336745984; Read time: 26137; Write time: 609 14:56:34 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 188416; Write bytes: 340229120; Read time: 5; Write time: 1625 14:56:34 INFO - Running post-run listener: _upload_blobber_files 14:56:34 INFO - Blob upload gear active. 14:56:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:56:34 INFO - Copying logs to upload dir... 14:56:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.656389 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-24 14:56:34.975988) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 14:56:34.979943) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009842 build_url: 'https://queue.taskcluster.net/v1/task/41x5b9jeRWCfg-efCS3o1w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.28 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 14:56:35.271060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:56:35.271468) ========= 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.pjdKwhyMtZ/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.L40F9BrJAg/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005177 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 14:56:35.290133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 14:56:35.290483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 14:56:35.290957) ========= ========= Total master_lag: 0.48 =========