builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0035 starttime: 1448308457.66 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.658129) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.658532) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.658830) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005783 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.679133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.679457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.693731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.694086) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.742218) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.742526) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.742888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.743164) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-23 11:54:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.42M=0.001s 2015-11-23 11:54:17 (8.42 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170538 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.926814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.927115) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.019282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:17.975302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-23 11:54:17.975648) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-23 11:54:18,024 truncating revision to first 12 chars 2015-11-23 11:54:18,024 Setting DEBUG logging. 2015-11-23 11:54:18,024 attempt 1/10 2015-11-23 11:54:18,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:54:20,007 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.222051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-23 11:54:20.211471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:20.212596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:20.225984) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:20.226302) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:20.226723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 11:54:20.227002) ========= /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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:20 INFO - MultiFileLogger online at 20151123 11:54:20 in /builds/slave/test 11:54:20 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 11:54:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:20 INFO - {'append_to_log': False, 11:54:20 INFO - 'base_work_dir': '/builds/slave/test', 11:54:20 INFO - 'blob_upload_branch': 'Fx-Team', 11:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:20 INFO - 'branch': 'Fx-Team', 11:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:20 INFO - 'config_files': ('talos/mac_config.py',), 11:54:20 INFO - 'default_actions': ('clobber', 11:54:20 INFO - 'read-buildbot-config', 11:54:20 INFO - 'download-and-extract', 11:54:20 INFO - 'populate-webroot', 11:54:20 INFO - 'create-virtualenv', 11:54:20 INFO - 'install', 11:54:20 INFO - 'run-tests'), 11:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:20 INFO - 'download_minidump_stackwalk': True, 11:54:20 INFO - 'download_symbols': 'ondemand', 11:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:20 INFO - 'installer_path': 'installer.exe', 11:54:20 INFO - 'log_level': 'info', 11:54:20 INFO - 'log_name': 'talos', 11:54:20 INFO - 'log_to_console': True, 11:54:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:20 INFO - 'opt_config_files': (), 11:54:20 INFO - 'pip_index': False, 11:54:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:20 INFO - 'cmd': ('bash', 11:54:20 INFO - '-c', 11:54:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:20 INFO - 'enabled': True, 11:54:20 INFO - 'halt_on_failure': False, 11:54:20 INFO - 'name': 'check_screen_resolution'},), 11:54:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:20 INFO - 'cmd': ('bash', 11:54:20 INFO - '-c', 11:54:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:20 INFO - 'enabled': True, 11:54:20 INFO - 'halt_on_failure': False, 11:54:20 INFO - 'name': 'check_screen_resolution'},), 11:54:20 INFO - 'run_cmd_checks_enabled': True, 11:54:20 INFO - 'sps_profile': False, 11:54:20 INFO - 'sps_profile_interval': 0, 11:54:20 INFO - 'suite': 'dromaeojs', 11:54:20 INFO - 'system_bits': '64', 11:54:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:20 INFO - 'title': 't-yosemite-r7-0035', 11:54:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:20 INFO - 'use_talos_json': True, 11:54:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:20 INFO - 'work_dir': 'build'} 11:54:20 INFO - ##### 11:54:20 INFO - ##### Running clobber step. 11:54:20 INFO - ##### 11:54:20 INFO - Running pre-action listener: _resource_record_pre_action 11:54:20 INFO - Running main action method: clobber 11:54:20 INFO - rmtree: /builds/slave/test/build 11:54:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:21 INFO - Running post-action listener: _resource_record_post_action 11:54:21 INFO - ##### 11:54:21 INFO - ##### Running read-buildbot-config step. 11:54:21 INFO - ##### 11:54:21 INFO - Running pre-action listener: _resource_record_pre_action 11:54:21 INFO - Running main action method: read_buildbot_config 11:54:21 INFO - Using buildbot properties: 11:54:21 INFO - { 11:54:21 INFO - "properties": { 11:54:21 INFO - "buildnumber": 17, 11:54:21 INFO - "product": "firefox", 11:54:21 INFO - "script_repo_revision": "production", 11:54:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:54:21 INFO - "repository": "", 11:54:21 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:54:21 INFO - "buildid": "20151123050554", 11:54:21 INFO - "slavename": "t-yosemite-r7-0035", 11:54:21 INFO - "pgo_build": "False", 11:54:21 INFO - "basedir": "/builds/slave/test", 11:54:21 INFO - "project": "", 11:54:21 INFO - "platform": "yosemite_r7", 11:54:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:54:21 INFO - "slavebuilddir": "test", 11:54:21 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:54:21 INFO - "branch": "fx-team", 11:54:21 INFO - "repo_path": "integration/fx-team", 11:54:21 INFO - "stage_platform": "macosx64", 11:54:21 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:54:21 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:21 INFO - }, 11:54:21 INFO - "sourcestamp": { 11:54:21 INFO - "repository": "", 11:54:21 INFO - "hasPatch": false, 11:54:21 INFO - "project": "", 11:54:21 INFO - "branch": "fx-team-macosx64-talos", 11:54:21 INFO - "changes": [ 11:54:21 INFO - { 11:54:21 INFO - "category": null, 11:54:21 INFO - "files": [ 11:54:21 INFO - { 11:54:21 INFO - "url": null, 11:54:21 INFO - "name": "https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:54:21 INFO - } 11:54:21 INFO - ], 11:54:21 INFO - "repository": "", 11:54:21 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:54:21 INFO - "who": "pbrosset@mozilla.com", 11:54:21 INFO - "when": 1448289287, 11:54:21 INFO - "number": 6695012, 11:54:21 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:54:21 INFO - "project": "", 11:54:21 INFO - "at": "Mon 23 Nov 2015 06:34:47", 11:54:21 INFO - "branch": "fx-team-macosx64-talos", 11:54:21 INFO - "revlink": "", 11:54:21 INFO - "properties": [ 11:54:21 INFO - [ 11:54:21 INFO - "buildid", 11:54:21 INFO - "20151123050554", 11:54:21 INFO - "Change" 11:54:21 INFO - ], 11:54:21 INFO - [ 11:54:21 INFO - "builduid", 11:54:21 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:54:21 INFO - "Change" 11:54:21 INFO - ], 11:54:21 INFO - [ 11:54:21 INFO - "pgo_build", 11:54:21 INFO - "False", 11:54:21 INFO - "Change" 11:54:21 INFO - ] 11:54:21 INFO - ], 11:54:21 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:21 INFO - } 11:54:21 INFO - ], 11:54:21 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:21 INFO - } 11:54:21 INFO - } 11:54:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:54:21 INFO - Running post-action listener: _resource_record_post_action 11:54:21 INFO - ##### 11:54:21 INFO - ##### Running download-and-extract step. 11:54:21 INFO - ##### 11:54:21 INFO - Running pre-action listener: _resource_record_pre_action 11:54:21 INFO - Running main action method: download_and_extract 11:54:21 INFO - mkdir: /builds/slave/test/build/tests 11:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:21 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:54:22 INFO - Downloaded 1149 bytes. 11:54:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:54:22 INFO - Using the following test package requirements: 11:54:22 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:22 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:54:22 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'jsshell-mac.zip'], 11:54:22 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:54:22 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:22 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:54:22 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:54:22 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:54:22 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:22 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:22 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:54:22 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:22 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:23 INFO - Downloaded 17525254 bytes. 11:54:23 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 11:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:54:26 INFO - Return code: 0 11:54:26 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 11:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:26 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:27 INFO - Downloaded 17525254 bytes. 11:54:27 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 11:54:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:54:31 INFO - Return code: 0 11:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:31 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:31 INFO - Downloaded 11130997 bytes. 11:54:31 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 11:54:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:54:32 INFO - Return code: 0 11:54: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')]} 11:54:32 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:54:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:35 INFO - Downloaded 109634929 bytes. 11:54:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:35 INFO - mkdir: /builds/slave/test/properties 11:54:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:35 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:35 INFO - Contents: 11:54:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:35 INFO - Running post-action listener: _resource_record_post_action 11:54:35 INFO - Running post-action listener: set_extra_try_arguments 11:54:35 INFO - ##### 11:54:35 INFO - ##### Running populate-webroot step. 11:54:35 INFO - ##### 11:54:35 INFO - Running pre-action listener: _resource_record_pre_action 11:54:35 INFO - Running main action method: populate_webroot 11:54:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:54:35 INFO - '../fennec_ids.txt'], 11:54:35 INFO - 'tests': ['tcheck2']}, 11:54:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:35 INFO - '--tppagecycles', 11:54:35 INFO - '7'], 11:54:35 INFO - 'tests': ['tsvgm']}}, 11:54:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:54:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'tests': ['damp', 'tps']}, 11:54:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['damp', 'tps']}, 11:54:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:54:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:35 INFO - 'other': {'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'other_l64': {'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'other_nol64': {'tests': ['a11yr', 11:54:35 INFO - 'ts_paint', 11:54:35 INFO - 'tpaint', 11:54:35 INFO - 'sessionrestore', 11:54:35 INFO - 'sessionrestore_no_auto_restore']}, 11:54:35 INFO - 'svgr': {'tests': ['tsvgx', 11:54:35 INFO - 'tsvgr_opacity', 11:54:35 INFO - 'tart', 11:54:35 INFO - 'tscrollx', 11:54:35 INFO - 'cart']}, 11:54:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['tsvgx', 11:54:35 INFO - 'tsvgr_opacity', 11:54:35 INFO - 'tart', 11:54:35 INFO - 'tscrollx', 11:54:35 INFO - 'cart']}, 11:54:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'tests': ['tp5o']}, 11:54:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'talos_options': ['--e10s'], 11:54:35 INFO - 'tests': ['tp5o']}, 11:54:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'talos_options': ['--xperf_path', 11:54:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:35 INFO - 'tests': ['tp5n']}, 11:54:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:35 INFO - 'talos_options': ['--e10s', 11:54:35 INFO - '--xperf_path', 11:54:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:35 INFO - 'tests': ['tp5n']}}, 11:54:35 INFO - 'talos.zip': {'path': '', 11:54:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:35 INFO - Running post-action listener: _resource_record_post_action 11:54:35 INFO - ##### 11:54:35 INFO - ##### Running create-virtualenv step. 11:54:35 INFO - ##### 11:54:35 INFO - Running pre-action listener: _resource_record_pre_action 11:54:35 INFO - Running main action method: create_virtualenv 11:54:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:35 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 11:54:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:35 INFO - Using real prefix '/tools/python27' 11:54:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:38 INFO - Installing pip.................done. 11:54:38 INFO - Return code: 0 11:54:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54: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', 'pip>=1.5'] in /builds/slave/test/build 11:54: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 pip>=1.5 11:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:38 INFO - 'HOME': '/Users/cltbld', 11:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:38 INFO - 'LOGNAME': 'cltbld', 11:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:38 INFO - 'MOZ_NO_REMOTE': '1', 11:54:38 INFO - 'NO_EM_RESTART': '1', 11:54:38 INFO - 'PAGER': '/bin/cat', 11:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:38 INFO - 'PWD': '/builds/slave/test', 11:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:38 INFO - 'SHELL': '/bin/bash', 11:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:38 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:38 INFO - 'USER': 'cltbld', 11:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:38 INFO - 'XPC_FLAGS': '0x0', 11:54:38 INFO - 'XPC_SERVICE_NAME': '0', 11:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:39 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 11:54:39 INFO - Cleaning up... 11:54:39 INFO - Return code: 0 11:54:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:39 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 11:54:39 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 11:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:39 INFO - 'HOME': '/Users/cltbld', 11:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:39 INFO - 'LOGNAME': 'cltbld', 11:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:39 INFO - 'MOZ_NO_REMOTE': '1', 11:54:39 INFO - 'NO_EM_RESTART': '1', 11:54:39 INFO - 'PAGER': '/bin/cat', 11:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:39 INFO - 'PWD': '/builds/slave/test', 11:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:39 INFO - 'SHELL': '/bin/bash', 11:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:39 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:39 INFO - 'USER': 'cltbld', 11:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:39 INFO - 'XPC_FLAGS': '0x0', 11:54:39 INFO - 'XPC_SERVICE_NAME': '0', 11:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:39 INFO - Downloading/unpacking psutil>=0.7.1 11:54:39 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 11:54:39 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 11:54:39 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 11:54:39 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 11:54:39 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 11:54:39 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 11:54:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:54:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:42 INFO - Installing collected packages: psutil 11:54:42 INFO - Running setup.py install for psutil 11:54:42 INFO - building 'psutil._psutil_osx' extension 11:54:42 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 11:54:42 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 11:54:42 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 11:54:42 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 11:54:42 INFO - building 'psutil._psutil_posix' extension 11:54:42 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 11:54:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:54:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:54:42 INFO - ^ 11:54:42 INFO - 1 warning generated. 11:54:42 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 11:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:42 INFO - Successfully installed psutil 11:54:42 INFO - Cleaning up... 11:54:42 INFO - Return code: 0 11:54:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:54:42 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')]} 11:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:42 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')]} 11:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:42 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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:42 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 11:54:42 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 11:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:42 INFO - 'HOME': '/Users/cltbld', 11:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:42 INFO - 'LOGNAME': 'cltbld', 11:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:42 INFO - 'MOZ_NO_REMOTE': '1', 11:54:42 INFO - 'NO_EM_RESTART': '1', 11:54:42 INFO - 'PAGER': '/bin/cat', 11:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:42 INFO - 'PWD': '/builds/slave/test', 11:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:42 INFO - 'SHELL': '/bin/bash', 11:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:42 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:42 INFO - 'USER': 'cltbld', 11:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:42 INFO - 'XPC_FLAGS': '0x0', 11:54:42 INFO - 'XPC_SERVICE_NAME': '0', 11:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:54:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:54:45 INFO - Installing collected packages: mozsystemmonitor 11:54:45 INFO - Running setup.py install for mozsystemmonitor 11:54:45 INFO - Successfully installed mozsystemmonitor 11:54:45 INFO - Cleaning up... 11:54:45 INFO - Return code: 0 11:54:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:45 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 11:54:45 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 11:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:45 INFO - 'HOME': '/Users/cltbld', 11:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:45 INFO - 'LOGNAME': 'cltbld', 11:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:45 INFO - 'MOZ_NO_REMOTE': '1', 11:54:45 INFO - 'NO_EM_RESTART': '1', 11:54:45 INFO - 'PAGER': '/bin/cat', 11:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:45 INFO - 'PWD': '/builds/slave/test', 11:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:45 INFO - 'SHELL': '/bin/bash', 11:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:45 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:45 INFO - 'USER': 'cltbld', 11:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:45 INFO - 'XPC_FLAGS': '0x0', 11:54:45 INFO - 'XPC_SERVICE_NAME': '0', 11:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:45 INFO - Downloading/unpacking blobuploader==1.2.4 11:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:48 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 11:54:49 INFO - Downloading docopt-0.6.1.tar.gz 11:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:49 INFO - Running setup.py install for blobuploader 11:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:49 INFO - Running setup.py install for requests 11:54:49 INFO - Running setup.py install for docopt 11:54:49 INFO - Successfully installed blobuploader requests docopt 11:54:49 INFO - Cleaning up... 11:54:50 INFO - Return code: 0 11:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:50 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')]} 11:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:50 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')]} 11:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:50 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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:50 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 11:54:50 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 11:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:50 INFO - 'HOME': '/Users/cltbld', 11:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:50 INFO - 'LOGNAME': 'cltbld', 11:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:50 INFO - 'MOZ_NO_REMOTE': '1', 11:54:50 INFO - 'NO_EM_RESTART': '1', 11:54:50 INFO - 'PAGER': '/bin/cat', 11:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:50 INFO - 'PWD': '/builds/slave/test', 11:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:50 INFO - 'SHELL': '/bin/bash', 11:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:50 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:50 INFO - 'USER': 'cltbld', 11:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:50 INFO - 'XPC_FLAGS': '0x0', 11:54:50 INFO - 'XPC_SERVICE_NAME': '0', 11:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ROXvSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Ly4Psp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-MnQTFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-GWDVSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-vE4FWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QgKJjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-036fKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:50 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-KvPeEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-VittNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-4tsb_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-bclsUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-oPXSUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-F7DqbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-48Jw7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-UjTdwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-68mnGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:51 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SAlwcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:52 INFO - Running setup.py install for manifestparser 11:54:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:52 INFO - Running setup.py install for mozcrash 11:54:52 INFO - Running setup.py install for mozdebug 11:54:52 INFO - Running setup.py install for mozdevice 11:54:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:52 INFO - Running setup.py install for mozfile 11:54:52 INFO - Running setup.py install for mozhttpd 11:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:52 INFO - Running setup.py install for mozinfo 11:54:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Running setup.py install for mozInstall 11:54:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Running setup.py install for mozleak 11:54:53 INFO - Running setup.py install for mozlog 11:54:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Running setup.py install for moznetwork 11:54:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Running setup.py install for mozprocess 11:54:53 INFO - Running setup.py install for mozprofile 11:54:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:53 INFO - Running setup.py install for mozrunner 11:54:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:54 INFO - Running setup.py install for mozscreenshot 11:54:54 INFO - Running setup.py install for moztest 11:54:54 INFO - Running setup.py install for mozversion 11:54:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:54 INFO - Cleaning up... 11:54:54 INFO - Return code: 0 11:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:54 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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:54 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 11:54:54 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 11:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:54 INFO - 'HOME': '/Users/cltbld', 11:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:54 INFO - 'LOGNAME': 'cltbld', 11:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:54 INFO - 'MOZ_NO_REMOTE': '1', 11:54:54 INFO - 'NO_EM_RESTART': '1', 11:54:54 INFO - 'PAGER': '/bin/cat', 11:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:54 INFO - 'PWD': '/builds/slave/test', 11:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:54 INFO - 'SHELL': '/bin/bash', 11:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:54 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:54 INFO - 'USER': 'cltbld', 11:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:54 INFO - 'XPC_FLAGS': '0x0', 11:54:54 INFO - 'XPC_SERVICE_NAME': '0', 11:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-XK_WFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:54 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)) 11:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:54 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Y_rz5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-73B_TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-MqsEKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Km7zMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-yBK2Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-MWjK6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nelNGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ZonXTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:55 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)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-5b2ULa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:55 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Xb8jii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-kJivvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-4gaPi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-GVqNUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-gePCyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-C8C5_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:56 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)) 11:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:56 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-LvXTRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:56 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)) 11:54:56 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)) 11:54:56 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)) 11:54:56 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)) 11:54:56 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)) 11:54:56 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)) 11:54:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:56 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 11:54:56 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 11:54:56 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 11:54:56 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 11:54:56 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 11:54:56 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 11:54:58 INFO - Downloading blessings-1.5.1.tar.gz 11:54:58 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 11:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:58 INFO - Installing collected packages: blessings 11:54:58 INFO - Running setup.py install for blessings 11:54:59 INFO - Successfully installed blessings 11:54:59 INFO - Cleaning up... 11:54:59 INFO - Return code: 0 11:54:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:59 INFO - Reading from file tmpfile_stdout 11:54:59 INFO - Current package versions: 11:54:59 INFO - blessings == 1.5.1 11:54:59 INFO - blobuploader == 1.2.4 11:54:59 INFO - docopt == 0.6.1 11:54:59 INFO - manifestparser == 1.1 11:54:59 INFO - mozInstall == 1.12 11:54:59 INFO - mozcrash == 0.16 11:54:59 INFO - mozdebug == 0.1 11:54:59 INFO - mozdevice == 0.47 11:54:59 INFO - mozfile == 1.2 11:54:59 INFO - mozhttpd == 0.7 11:54:59 INFO - mozinfo == 0.9 11:54:59 INFO - mozleak == 0.1 11:54:59 INFO - mozlog == 3.0 11:54:59 INFO - moznetwork == 0.27 11:54:59 INFO - mozprocess == 0.22 11:54:59 INFO - mozprofile == 0.27 11:54:59 INFO - mozrunner == 6.11 11:54:59 INFO - mozscreenshot == 0.1 11:54:59 INFO - mozsystemmonitor == 0.0 11:54:59 INFO - moztest == 0.7 11:54:59 INFO - mozversion == 1.4 11:54:59 INFO - psutil == 3.1.1 11:54:59 INFO - requests == 1.2.3 11:54:59 INFO - wsgiref == 0.1.2 11:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:59 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')]} 11:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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')]} 11:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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 0x10baca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530495820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, '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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 11:54:59 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 11:54:59 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 11:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:59 INFO - 'HOME': '/Users/cltbld', 11:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:59 INFO - 'LOGNAME': 'cltbld', 11:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:59 INFO - 'MOZ_NO_REMOTE': '1', 11:54:59 INFO - 'NO_EM_RESTART': '1', 11:54:59 INFO - 'PAGER': '/bin/cat', 11:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:59 INFO - 'PWD': '/builds/slave/test', 11:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:59 INFO - 'SHELL': '/bin/bash', 11:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:54:59 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:59 INFO - 'USER': 'cltbld', 11:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:59 INFO - 'XPC_FLAGS': '0x0', 11:54:59 INFO - 'XPC_SERVICE_NAME': '0', 11:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 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)) 11:54:59 INFO - Cleaning up... 11:54:59 INFO - Return code: 0 11:54:59 INFO - Running post-action listener: _resource_record_post_action 11:54:59 INFO - Running post-action listener: _start_resource_monitoring 11:54:59 INFO - Starting resource monitoring. 11:54:59 INFO - ##### 11:54:59 INFO - ##### Running install step. 11:54:59 INFO - ##### 11:54:59 INFO - Running pre-action listener: _resource_record_pre_action 11:54:59 INFO - Running main action method: install 11:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:59 INFO - Reading from file tmpfile_stdout 11:54:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:00 INFO - Reading from file tmpfile_stdout 11:55:00 INFO - Output received: 11:55:00 INFO - Usage: mozinstall [options] installer 11:55:00 INFO - Options: 11:55:00 INFO - -h, --help show this help message and exit 11:55:00 INFO - -d DEST, --destination=DEST 11:55:00 INFO - Directory to install application into. [default: 11:55:00 INFO - "/builds/slave/test"] 11:55:00 INFO - --app=APP Application being installed. [default: firefox] 11:55:00 INFO - mkdir: /builds/slave/test/build/application 11:55:00 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'] 11:55:00 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 11:55:30 INFO - Reading from file tmpfile_stdout 11:55:30 INFO - Output received: 11:55:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:55:30 INFO - Running post-action listener: _resource_record_post_action 11:55:30 INFO - ##### 11:55:30 INFO - ##### Running run-tests step. 11:55:30 INFO - ##### 11:55:30 INFO - Running pre-action listener: _resource_record_pre_action 11:55:30 INFO - Running main action method: run_tests 11:55:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:55:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:55:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:55:30 INFO - 2015-11-23 11:55:30.341 screenresolution[2012:10592] starting screenresolution argv=screenresolution get 11:55:30 INFO - 2015-11-23 11:55:30.343 screenresolution[2012:10592] Display 0: 1600x1200x32@60 11:55:30 INFO - 2015-11-23 11:55:30.349 screenresolution[2013:10594] starting screenresolution argv=screenresolution list 11:55:30 INFO - Available Modes on Display 0 11:55:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:55:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:55:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:55:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:55:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:55:30 INFO - Intel Iris: 11:55:30 INFO - Chipset Model: Intel Iris 11:55:30 INFO - Type: GPU 11:55:30 INFO - Bus: Built-In 11:55:30 INFO - VRAM (Dynamic, Max): 1536 MB 11:55:30 INFO - Vendor: Intel (0x8086) 11:55:30 INFO - Device ID: 0x0a2e 11:55:30 INFO - Revision ID: 0x0009 11:55:30 INFO - Displays: 11:55:30 INFO - Display: 11:55:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:55:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:55:30 INFO - Display Serial Number: 1600x1200 60 11:55:30 INFO - Main Display: Yes 11:55:30 INFO - Mirror: Off 11:55:30 INFO - Online: Yes 11:55:30 INFO - Rotation: Supported 11:55:30 INFO - Return code: 0 11:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:30 INFO - Python 2.7.3 11:55:30 INFO - Return code: 0 11:55:30 INFO - grabbing minidump binary from tooltool 11:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:55:30 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 0x10b9ee9f0>, '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 0x10b74ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e18c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:30 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 11:55:30 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 11:55:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:30 INFO - Return code: 0 11:55:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:30 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/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost'] in /builds/slave/test/build 11:55:30 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/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --webServer localhost 11:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgdSi7uTqf/Render', 11:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:30 INFO - 'HOME': '/Users/cltbld', 11:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:30 INFO - 'LOGNAME': 'cltbld', 11:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:30 INFO - 'MOZ_NO_REMOTE': '1', 11:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:30 INFO - 'NO_EM_RESTART': '1', 11:55:30 INFO - 'PAGER': '/bin/cat', 11:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:30 INFO - 'PWD': '/builds/slave/test', 11:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:30 INFO - 'SHELL': '/bin/bash', 11:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AsbtJKYAI2/Listeners', 11:55:30 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 11:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:30 INFO - 'USER': 'cltbld', 11:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:30 INFO - 'XPC_FLAGS': '0x0', 11:55:30 INFO - 'XPC_SERVICE_NAME': '0', 11:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:30 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/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost'] with output_timeout 3600 11:55:30 INFO - mozversion INFO | application_buildid: 20151123050554 11:55:30 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:55:30 INFO - mozversion INFO | application_display_name: Nightly 11:55:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:30 INFO - mozversion INFO | application_name: Firefox 11:55:30 INFO - mozversion INFO | application_remotingname: firefox 11:55:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:55:30 INFO - mozversion INFO | application_vendor: Mozilla 11:55:30 INFO - mozversion INFO | application_version: 45.0a1 11:55:30 INFO - mozversion INFO | platform_buildid: 20151123050554 11:55:30 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:55:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:55:30 INFO - mozversion INFO | platform_version: 45.0a1 11:55:30 INFO - 2015-11-23 11:55:30,884 DEBUG : using testdate: 1448308530 11:55:30 INFO - 2015-11-23 11:55:30,884 DEBUG : actual date: 1448308530 11:55:31 INFO - 2015-11-23 11:55:31,256 INFO : starting webserver on 'localhost:49533' 11:55:31 INFO - 2015-11-23 11:55:31,257 INFO : Starting test suite t-yosemite-r7-0035 11:55:31 INFO - 2015-11-23 11:55:31,257 INFO : Starting test dromaeo_css 11:55:31 INFO - 2015-11-23 11:55:31,257 DEBUG : operating with platform_type : mac_ 11:55:31 INFO - 2015-11-23 11:55:31,258 INFO : Initialising browser for dromaeo_css test... 11:55:31 INFO - 2015-11-23 11:55:31,271 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpEKiF8C/profile http://localhost:49533/getInfo.html 11:55:33 INFO - 2015-11-23 11:55:33,217 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:55:33 INFO - 2015-11-23 11:55:33,217 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:55:33 INFO - 2015-11-23 11:55:33,217 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:55:33 INFO - 2015-11-23 11:55:33,218 DEBUG : BROWSER_OUTPUT: __metrics 11:55:33 INFO - 2015-11-23 11:55:33,234 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:33 INFO - 2015-11-23 11:55:33,985 INFO : Browser initialized. 11:55:33 INFO - 2015-11-23 11:55:33,985 INFO : Running cycle 1/1 for dromaeo_css test... 11:55:33 INFO - 2015-11-23 11:55:33,985 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpEKiF8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:55:45 INFO - 2015-11-23 11:55:45,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 226131968 11:55:45 INFO - 2015-11-23 11:55:45,805 DEBUG : BROWSER_OUTPUT: 11:56:36 INFO - 2015-11-23 11:56:36,825 DEBUG : BROWSER_OUTPUT: 1448308596817 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] 11:58:48 INFO - 2015-11-23 11:58:48,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49533/tests/dromaeo/cssquery-ext.html) 11:58:49 INFO - 2015-11-23 11:58:49,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 327868416 11:58:49 INFO - 2015-11-23 11:58:49,867 DEBUG : BROWSER_OUTPUT: 12:01:52 INFO - 2015-11-23 12:01:52,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-ext.html (next: http://localhost:49533/tests/dromaeo/cssquery-jquery.html) 12:01:53 INFO - 2015-11-23 12:01:53,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 358281216 12:01:53 INFO - 2015-11-23 12:01:53,079 DEBUG : BROWSER_OUTPUT: 12:04:55 INFO - 2015-11-23 12:04:55,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49533/tests/dromaeo/cssquery-mootools.html) 12:04:55 INFO - 2015-11-23 12:04:55,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 333873152 12:04:55 INFO - 2015-11-23 12:04:55,597 DEBUG : BROWSER_OUTPUT: 12:07:57 INFO - 2015-11-23 12:07:57,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49533/tests/dromaeo/cssquery-prototype.html) 12:07:58 INFO - 2015-11-23 12:07:58,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 317816832 12:07:58 INFO - 2015-11-23 12:07:58,237 DEBUG : BROWSER_OUTPUT: 12:11:01 INFO - 2015-11-23 12:11:01,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49533/tests/dromaeo/cssquery-yui.html) 12:11:01 INFO - 2015-11-23 12:11:01,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 318849024 12:11:01 INFO - 2015-11-23 12:11:01,929 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-yui.html (next: http://localhost:49533/tests/dromaeo/cssquery-dojo.html) 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 359866368 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:14:04 INFO - 2015-11-23 12:14:04,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:14:04 INFO - 2015-11-23 12:14:04,730 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3484.6166921638624;3544.6809787119155;3566.179778650912;3567.5362202913616;3587.2108136210027;5781.653100813944;5903.114532820068;5932.851678708034;6078.300995385532;6093.817185484431;5945.286565612122;5950.55370847186;5992.640441573509;6082.4221698938645;6105.511559075275;5366.168243922199;5417.26866872973;5427.348718153827;5437.8368648940395;5458.808941687042;5560.277163968678;5566.276384070065;5575.135853942646;5576.609637325369;5594.412586678402;4615.192341340269;5237.47625237477;5327;5384.865378365533;5550.306211723514;4982.227754698028;4986.975065124688;5415.10650742627;5431.158170483542;5450.836474905759;5305.071612467841;5396;5412.648177868426;5413.621046526745;5416.91874621881;4592.678512504126;5872.383399743051;5878.676672783038;5878.883012227663;5882.911756323659;6302.338254483259;6327.4938004959495;6329.683515824237;6339.429451349354;6390.55266131371;6395.264544577387;6467.353264673495;6472.9029064564065;6484.124643173205;6507.837304067389;6178.938210617926;6183.443490085914;6193.969030154865;6201.410865967726;6201.6899155042065;6287.591306565058;6398.264199617103;6422.903656445157;6474.255460621995;6605.438537724252;5261.237120617489;6332.366763323631;6354.682265886687;6368.872622547523;6381;6459.806205813833;6461.838454038592;6463.192100987377;6477.319881412478;6489.870202595922;6169.660668663177;6320.494360451153;6329.778457753957;6353.459955903708;6367.4906007519285;6245;6324.114623952651;6332.461740752087;6335.11308416822;6343;5126.051680439131;5147.948520514822;5149.2791009258735;5152.252923326097;5171.612129090333;4516.299973504112;4593.977030114828;4602.976985115053;4636.327732478771;4654.581087702123;5968.7015649217365;6089.629833287563;6097.359777223416;6104.511639068864;6117.401149625483;6421.8073457796345;6431.421172094534;6459.741610335534;6460.160179176677;6468.450181734511;5862.589618726648;5985.730642121115;6008.699565021819;6084.665343406155;6091.208142941389;5401.675899446046;5466.480684334982;5478.04134276508;5502.944970550323;5521.641093329001;6380.330065343072;6457.321981191907;6459.580127291711;6467.773627923;6468.676566171673;6169.691515424301;6434.647488893744;6490.643014634241;6492.091107245084;6499.3175716549085;6287.245530536182;6349.68251587428;6370.076338930921;6421.133147025092;6467.547271690936;6368.9044664330995;6386.233651961795;6386.776462823779;6390.872182556416;6398.296187419473;5589.049861523632;6419.069234960998;6478.546501744832;6494.837629059311;6497.9025314619375;6129.847850912788;6143.078538219303;6231.376862313732;6277.466415354564;6296.811095667137;6267.122602835698;6282.465990390868;6310.242770867525;6312.747490100528;6316.778912738032;5383.434739352469;6115.785947491817;6267.9373206267355;6270.529710271657;6279.560430769802;4541.978054937613;6170.352113028068;6275.184226050585;6277.027060805583;6290.308066112632;6204.968975155095;6249.625022498664;6283.748650053946;6293.55945083858;6301.149344838388 12:14:04 INFO - 2015-11-23 12:14:04,734 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.2943432406521;585.122316525212;593.8366949089;620.2587907450595;632.1245075570336;23919.880400597995;41788.37317440241;41934.58065419345;41944.58055419445;42090.57909420909;44696.3295550567;45099;45100.3234951476;45314.7734261329;45325.32012019822;8520.318374530054;8852.911470885274;8894.843670322849;9785.363951343175;10035.69892903214;8747.343949203803;12129.272243665364;12287.877121228763;12302.200356976813;12330.876691233063;12039.398030098504;12146.089043321743;12154.453049612788;12157.756844863097;12170.026397888192;9006;9109.043550427175;9124.635014599407;11974.880251197506;12090.879091209152;11890.762184756342;12013.759724805543;12041.277523348626;12053.276803391824;12062.517499300018;40932;41260.79369603163;41308;41330;41411.1717765643;3268.9866141495972;3293.75296852737;3319.3859136059664;3561.7684850484893;3841.3277676406797;29377.706222937926;29663.703362966527;30009.849950750326;30331.545026824617;30517.69482305193;2698.9595156072673;2766.239284196862;2772.099067802952;2772.279207406069;2801.1176479409123;504788.476057621;506423;506568;507035;507349;48935;70257.64871175612;70951.2904870955;70982;71064;68377.65811171012;68801.3119868805;69089;69412.61174776476;69462;16736;16913.7462938056;16935.068571228454;16978.06620635877;16994.660106797794;12808.551700690432;13093;13111;13112.278824664734;13117.803232951514;16638.50084497467;20369.490762730755;20411.285605003755;20429.284975025803;20489.38531844047;8642;8808.823823523493;8815.074417186102;8853.69012084574;8861.335399845037;804.3685706720197;927.4342650982895;953.6900507335143;953.7949340891603;1105.1876870500175;27437;27978.72021279802;28116.437671246462;28374.290642734097;28543;1020.8162530744389;1085.1210519479089;1183.148133343991;1197.7484728207;1209.5524655877382;14152.787708184385;14904.627384315261;14906.403743850342;14926.328315225841;14940.477083302032;548384;554986;555068;555402;556168;60316.698416508516;60461.39538604557;60622;60673.69663151656;60803;1342.2013901728455;1440.9135451872921;1456.410153887677;1461.8099647045815;1470.9338079786435;25423.872880635477;29455.55816662709;30582.541261880644;30653;30858;49520.257196142804;49547.50452495573;49586.25620615766;49616.255756162966;50036.24945625746;492604;503672;543022.5697742972;551404.2429787825;553509;30156.849215754657;30177.698223018368;30365.848170759004;30373.088807335815;30410.543841841947;42041.57958420377;42506.36240456458;42510.1497970045;43051.56948430475;43686.34470483009;34094.31811363709;35502.11244718903;35696.821515892254;36507.452388213664;36535;32255;36218;36284.63715362812;37065.629343707296;37908.43137352887;36196.45705314475;37203.813980929925;38093.4285985716;38145;38693.806530967166;29961.700382995892;32295.51556726604;32359.51460728044;32508.674913250565;32561.674383255864;24574.63138052895;25210.99156033738;25418.872905635355;25429.72851357388;25706.971721130943 12:14:04 INFO - 2015-11-23 12:14:04,734 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.83627449510476;362.235682709483;362.5649220934879;370.5312779334142;374.67029014467266;15137.924310378432;17911.910440447813;19854.305099321507;20616.587668246644;20914;22095.66856497154;22105.115795368165;22453;22550.661740073912;22552.54894902105;4673.76631168442;6525.119108920294;6684.732610695566;6693.364130407628;6698.966505167467;4822.445418776851;5335.813246536372;7495.925040749605;7505.174430812606;7516.473846830724;7201.099862517185;7475.401967842587;7486.588237646927;7506.774796756106;7509.098908131032;6423.261324947621;7353.595552244625;7516.173220945691;7530.887036694481;7557.130929943044;7142.4286057115305;7161.606111663857;7165.390941769956;7174;7174.964125179341;24319.392015199763;27544.862275688694;27886.745096470706;28495;28626;2174.597699425611;2191.854688521976;2198.9890050549807;2225.9666105008437;2489.2283392148493;15303.005304655162;15484.070955742578;15688;15773.369065237377;16093.597660058593;1814.4828723813782;1816.2553353125288;1848.334599544163;1866.542697039234;1867.449102514748;99765;101344.49327753388;108363.45818270936;110662;116577;10780.784384312426;11111.83332250017;11121.499532521057;11165.218434709492;11194.552217911356;13263.801042984363;13264.668383290302;13287.20276783396;13293.20240785556;13323.93338033323;8469.491830490191;8551.444156129955;8566.186212309945;8632.654693812177;8645.827083458296;8737.30101591871;8741.912580874237;8748.56257187151;8825.161609647073;8839.911600884037;3858.8456461741216;3942.1327307992196;3959.109200429938;4290.249206388869;8520.488770673779;2838.303611569018;2921.3134913295785;3375.2574433624563;3421.5038819371052;3423.3495635829113;840.5083026429485;901.8827552418144;955.2739917662487;1007.8185926533148;1015.5633077776627;20445.591088178153;20802;20807;20818.58362832765;20964.47588810292;911.1708345405782;952.5142177489391;955.9808803824023;1016.8423894296396;1037.6783197208738;11185.440727963569;11528.596499122657;11543.36511491876;11545.711357215969;11554.884451155549;752914;756835;769907;778416;793335.0333248297;123941;127247;131246.68753312537;132282.33858830837;137337.3133134328;1047.607147319755;1064.5156453813652;1168.3223730236443;1179.1451197881638;1183.1303991566192;18725.438236852915;18845.90577047106;19000.904995474935;19012.144453499903;19081.950492723034;53869.19196212138;54418.72790636022;54632;54939.72530137324;55201.72399137979;70309;73320.63339683268;74232;76046.61976690081;78306.6084669573;9830.75423114428;9834.065763752433;10115.39307641544;10117.848232276669;10120.139788118093;14858.702825943205;15187.848121518644;17935.461936141935;19619.70570441473;20194.39416817498;15939.840601593836;16028;16056.839431605535;16156.838431615533;16238.025718456931;15366.463353664543;15522.456714014956;15636.765448518508;15748.133852638215;16074.035557866566;16196.109213993344;16358.263878125275;16405;16461.58846028811;16667.583310417336;9806.313558050868;10021.298509104292;10070.194384449373;10169.9491502542;10205.744856378353;10423.11403530678;13263.403146858607;16155.515334539983;16515.17424128813;16535.751963720795 12:14:04 INFO - 2015-11-23 12:14:04,738 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1599.8000249968754;1616.2726772952174;1691.1290685297067;1911.7573577174835;2030.857839951204;7507.099148102228;7885.763427097189;7914;7936.246056624625;8033.959830200841;8064.798380040487;8190.508569485835;8241.258286754191;8266.83466330673;8267.793305167374;2147.5382792699565;2375.1924345722496;2394.413368724665;2394.784469397754;2398.292503711409;2204.2836078274545;2205.0628482894786;2386.904523819054;2410.4214988402746;2413.3001429585397;2340.6957095577636;2380.4762952150586;2387.415083304593;2393.772591603795;2393.8444001139956;2144.0994782191515;2188.540406514634;2381.809455243585;2416.0577374823833;2417.8428402153804;2188.2888061380113;2334.124703236286;2384.0821283805685;2385.7256415512265;2386.809055275591;8204.425690201688;8438.11399803018;8457.323414126917;8469.49183049013;8471.110533394029;4325.52419233884;5247.606429517801;5286.65636733615;5286.973565132188;5295.655782374133;3491.6508349165133;3496.7202623790035;3512.7189824813954;3564.554430696163;3586.5337506124297;883.231588517987;1018.9337693050002;1023.626376372626;1061.0662616897082;1063.0751246415668;11133.997940185422;11147.777044459146;11152.219344645879;11169.106471482262;11184.776304473866;4613.423322084739;4670.673052886334;4733.242681171065;4755.167845627071;4771.33201351811;9713.07725766051;9756.46339451337;9765.658201962897;9778.119969202806;9781.510924453749;5244.501772331699;5247.868803279872;5268.367795864444;5268.868278292996;5272.578193744491;4785.712857228577;4805.951940480551;4821;4823.782929768169;4828.203346447867;3825.9426108608395;3882.514685664292;3894.7078969076865;3918.686505079587;3934.449177115206;1262.2552693910636;1292.7673018856508;1298.9350532473338;1307.3136603283353;1309.3387839141174;1353.0325817040864;1369.698666293414;1375.5116933488468;1398.6223719595855;1419.3825685826698;7762.184970578121;7941.6029198539845;7945.8410831784195;7947;7952.562609056557;501.81182056728727;505.2118694835994;509.4828748819951;511.0826067209294;514.6989011428357;5795.739191736382;5920.851978700567;5921.141434491975;6158.784442544489;6290.370962903673;9871.753206169904;9917.15704165154;9960.452175130438;10185.134263587677;10218.335808172593;9794.853077203848;9815.705528834147;9884.901150988542;9898.653547125816;9901.554430050664;7686.46194766361;7883.251091146332;7961.681532738626;7965.322947549524;7980.122186559473;7779.37764978789;7923.366130709414;7933.087694915159;7936.761897143095;7943.165967573322;8872.600732966903;8992.640294388151;9076.455412675261;9092.681756138503;9238.122378374044;9271.907280927375;9424.670136545188;9512.429254244767;9513;9522.476263805556;7303.634818259172;7392.630368481662;7394.630268486447;7404.185539590749;7424.257574242532;7743.380529557509;8002;8050.114487406498;8053.395995300493;8061.637226324947;5852.063669812809;6937.89593156093;7421.962890185515;7454.142773581108;7581.810454738455;7234;7358.521696089737;7424.0348754661545;7463.328300452985;7487.887681684888;7513.023306970059;7521.887171692539;7536.057992750906;7536.321731044232;7551.169371369035;6790.049393084873;6830.31696830313;6838.589684618939;6861.451083913175;6884.345987131214;6341.651209183539;6955.269696681776;6992.580445173306;7002.299770023161;7014.403775679124 12:14:04 INFO - 2015-11-23 12:14:04,739 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.4791960983012;331.86061854021307;332.247459504223;339.0117806593781;342.5803390846212;6900.378965893075;6903.516753827234;6915.44676425886;7025.683844227009;7033.8593228135405;6643.933560664404;6742.393184613384;6830.760923367683;6831.146106736658;6966.12923384577;5097.643164978453;5156.097682905495;5179.352580927384;5183.300254465656;5193.58451323895;4152.771597562133;5148.253503242027;5152.252923326116;5154.355705536808;5179.8446046618665;3863.9227215455676;4816.710997340153;4909.901801963959;4945.678530895499;4985.1774457214515;5010.073136469747;5083.932374201422;5098.9235161472425;5106.514881086291;5107.055194788976;4338.544452832471;4341.240282950471;4342.413774140482;4352.956470435319;4357.106793107406;6607.768728094542;6609.1408116944485;6633.93366066338;6645.136132302818;6653.101831252816;5855.326637436664;5989.700514974234;5991.340952495222;5993.4006599340155;6028.276606807167;7416;7419.777406677808;7421.628918554051;7430.517016393917;7434.070741157356;4884.4871288514905;4888.780004899752;4896.387951506062;4905.460399356068;4909.68087074339;7645.770626881203;7794.493357931717;7831.451798374116;7861.135275119732;7887.684492620346;4951.183054795991;4961.603071754251;4967.056259310792;4967.602591792648;4973.452920178777;5051.191809310566;5054.69671819692;5061.873453163626;5070.4929507049;5074.13739664258;4382.737035777864;5053.090443720165;5845.386234445322;6046.032634778502;6053;6398.976163813767;7129;7455.888161677579;7458.888116678254;7467.290607392289;1733.4886208568503;1750.5011071844463;1759.1643969114568;1759.3050744955672;1759.81521940197;1066.2962444786403;1080.621782376162;1090.2586241355955;1135.2904434728296;1156;6834.624095674686;6906.896396554056;6912.965435172892;6934.653267336714;7005.614691192033;7801.609919504002;7813.4921230121;7829.569373684388;7835.960820195863;7837.725679601187;6731.49513786468;7003.054587630707;7003.7548685795755;7005.894911576331;7006.719731210695;4083.591640835952;4104.671626269891;4124.608162224584;4126.319157339006;4132.648724858421;7793.2596403341595;7827.25641064098;7834.294913457816;7840.549498342711;7854.332381747501;7862.646180921873;8037.919620803717;8100.675972961016;8109.270165685117;8112.594370281462;7830.921690783133;7860.135385107634;7864.882026769717;7867.803304917423;7870.763877083811;7528.8494230116185;7782;7791.610419479117;7800.570968596555;7804.72683456099;6164.383561643979;7641.923580764344;7645.541267523967;7654.73208437702;7660.080790305199;7791.181925897926;7799.298063174115;7827.9608601956625;7829.804254893673;7831.960840195762;4670.579647831712;4745.9050818984115;4796.496367881322;4838.250071238823;4844.588210002189;7672.232776722283;7698.499597526143;7704.30661240491;7712.035995500562;7713.112992005991;7344.30229128232;7358.374538164316;7377.1885092638695;7381.594012329373;7382.2617738225745;7075.327843854826;7327.2672732726305;7328.743493977685;7343;7357.484976051625;7004.229534751275;7131.643417829192;7188.160676532845;7189.317014883578;7201.855962880818;6937.82655433598;7284.344409003003;7329.1937886833475;7338.522996005243;7339.74310899116;7231;7232.63836808168;7239.420846332386;7243.239459856639;7245.094363204599 12:14:04 INFO - 2015-11-23 12:14:04,740 DEBUG : BROWSER_OUTPUT: |5;yui.html;741.4216910809569;785.3520845302627;797.5175019113436;831.6049876308753;845.3575282785089;15040.699186016287;15413.537593872174;15427.69144617107;15430.61423464414;15440.459583914566;13788.034837561374;13842.377093030813;13971.16173029619;14380;14662.340194691238;951.609839965616;973.4548652754445;977.5063592885583;979.0356498848664;981.5533932060931;959.6545243712258;969.9418034917892;972.9124378805906;973.6056896956744;976.0093505092337;1022.734089136826;1034.1674951663908;1037.704254287528;1038.4911393417208;1040.6357774778842;1021.4024795494645;1028.0387837372007;1028.239103063735;1030.2118879057527;1030.7320096774893;758.2114600815146;760.2511526146741;760.3461023519768;761.3072104384983;761.7943155348025;13250;13372;13426.395812188475;13435.462581496728;13478;11038.889611103947;11050.33697978116;11061.889381106246;11143.219974601781;11148.99014924784;9514.143727064597;9521.1107962595;9653.565589548487;9690.46702431366;10020.949895250476;3240.206149493389;3285.1458620758535;3289.5723555937575;3315.154635567939;3332.733381329512;63612.303183455806;74753.5049299011;75960.86058709069;76546;80384.59807700982;8866.758653788474;9496.188513395962;9638.518074096268;9670;9775.21798256152;21691;21741.456463588536;21765.673514897288;21779.128834846746;23001;7449.106107267163;7595.050618672666;7672.5012874163;7778.766637000899;7783.260590243918;3992.4210989406374;4041.8383264669674;4055.7972101395403;4062.4921884764403;4070.3487442009136;3661.707063434919;3703.8888833335045;3705.9814700926863;3713.20166164276;3714.9628503714616;630.7855329188098;649.3506493506494;650.1353200243665;672.277301900459;672.8822456070168;480.5746913981152;487.1669445248594;489.1244672037014;512.9717865517358;514.054140381692;7860.410469214832;8221.342292616577;8262.8347433051;8357.164283571594;8484.207480430876;511.3352641565949;601.6342901613314;617.0867116667357;617.6016469377226;621.2482895696168;3669.43123815809;3975.423563583322;4058.837646494166;4233.25917964355;4285.528591854893;94241.58637620442;95253;95832.52083739536;98309.50845245727;99452.50273748585;72594.18514537073;75879.62060189774;82853.58573207095;84290.57854710687;85007.5749621248;59110;74586;75090;75992.48015039669;76416.61791691007;8651.394402391772;8777.824443511221;8802.64789408442;8942.46345219289;9027.954860225656;44092.897677558314;51114.74442627763;51912.480875192276;52001.479985199665;53380;41113.79443102765;59854.70072649609;61403.385966141555;61410;61749.69125154345;11267.323960562393;11277.71805704864;11306.773864522827;11387.829182562435;11611.361375124448;10866.728331791452;11916.702082448008;12526.812097818722;12550.309732964775;13332.333383330988;11089.27919685218;11312.717182070513;11513.597024104116;11715;12432.689182770504;11303;11491.770164596828;11615.88384116148;11625.59310424131;12254.592615045363;11047.668569942914;11107.333559986426;11248.156388270749;11454.484548195185;11991.280523168638;8703.84512392261;8805.603747831236;9020.684276050306;9410.670626528039;9496.810063798823;8854;8895.421797583136;9106.499142547224;9716.659916902874;9880.35777674449 12:14:04 INFO - 2015-11-23 12:14:04,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:14:04 INFO - 2015-11-23 12:14:04,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1211 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309644727__endTimestamp 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5912.34 Median:6193.97 stddev:664.51 (10.7%) stddev-sans-first:638.68 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: Values: 3484.6 3544.7 3566.2 3567.5 3587.2 5781.7 5903.1 5932.9 6078.3 6093.8 5945.3 5950.6 5992.6 6082.4 6105.5 5366.2 5417.3 5427.3 5437.8 5458.8 5560.3 5566.3 5575.1 5576.6 5594.4 4615.2 5237.5 5327.0 5384.9 5550.3 4982.2 4987.0 5415.1 5431.2 5450.8 5305.1 5396.0 5412.6 5413.6 5416.9 4592.7 5872.4 5878.7 5878.9 5882.9 6302.3 6327.5 6329.7 6339.4 6390.6 6395.3 6467.4 6472.9 6484.1 6507.8 6178.9 6183.4 6194.0 6201.4 6201.7 6287.6 6398.3 6422.9 6474.3 6605.4 5261.2 6332.4 6354.7 6368.9 6381.0 6459.8 6461.8 6463.2 6477.3 6489.9 6169.7 6320.5 6329.8 6353.5 6367.5 6245.0 6324.1 6332.5 6335.1 6343.0 5126.1 5147.9 5149.3 5152.3 5171.6 4516.3 4594.0 4603.0 4636.3 4654.6 5968.7 6089.6 6097.4 6104.5 6117.4 6421.8 6431.4 6459.7 6460.2 6468.5 5862.6 5985.7 6008.7 6084.7 6091.2 5401.7 5466.5 5478.0 5502.9 5521.6 6380.3 6457.3 6459.6 6467.8 6468.7 6169.7 6434.6 6490.6 6492.1 6499.3 6287.2 6349.7 6370.1 6421.1 6467.5 6368.9 6386.2 6386.8 6390.9 6398.3 5589.0 6419.1 6478.5 6494.8 6497.9 6129.8 6143.1 6231.4 6277.5 6296.8 6267.1 6282.5 6310.2 6312.7 6316.8 5383.4 6115.8 6267.9 6270.5 6279.6 4542.0 6170.4 6275.2 6277.0 6290.3 6205.0 6249.6 6283.7 6293.6 6301.1 12:14:04 INFO - 2015-11-23 12:14:04,742 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,744 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67371.94 Median:19629.30 stddev:141195.02 (719.3%) stddev-sans-first:141501.97 12:14:04 INFO - 2015-11-23 12:14:04,744 DEBUG : BROWSER_OUTPUT: Values: 551.3 585.1 593.8 620.3 632.1 23919.9 41788.4 41934.6 41944.6 42090.6 44696.3 45099.0 45100.3 45314.8 45325.3 8520.3 8852.9 8894.8 9785.4 10035.7 8747.3 12129.3 12287.9 12302.2 12330.9 12039.4 12146.1 12154.5 12157.8 12170.0 9006.0 9109.0 9124.6 11974.9 12090.9 11890.8 12013.8 12041.3 12053.3 12062.5 40932.0 41260.8 41308.0 41330.0 41411.2 3269.0 3293.8 3319.4 3561.8 3841.3 29377.7 29663.7 30009.8 30331.5 30517.7 2699.0 2766.2 2772.1 2772.3 2801.1 504788.5 506423.0 506568.0 507035.0 507349.0 48935.0 70257.6 70951.3 70982.0 71064.0 68377.7 68801.3 69089.0 69412.6 69462.0 16736.0 16913.7 16935.1 16978.1 16994.7 12808.6 13093.0 13111.0 13112.3 13117.8 16638.5 20369.5 20411.3 20429.3 20489.4 8642.0 8808.8 8815.1 8853.7 8861.3 804.4 927.4 953.7 953.8 1105.2 27437.0 27978.7 28116.4 28374.3 28543.0 1020.8 1085.1 1183.1 1197.7 1209.6 14152.8 14904.6 14906.4 14926.3 14940.5 548384.0 554986.0 555068.0 555402.0 556168.0 60316.7 60461.4 60622.0 60673.7 60803.0 1342.2 1440.9 1456.4 1461.8 1470.9 25423.9 29455.6 30582.5 30653.0 30858.0 49520.3 49547.5 49586.3 49616.3 50036.2 492604.0 503672.0 543022.6 551404.2 553509.0 30156.8 30177.7 30365.8 30373.1 30410.5 42041.6 42506.4 42510.1 43051.6 43686.3 34094.3 35502.1 35696.8 36507.5 36535.0 32255.0 36218.0 36284.6 37065.6 37908.4 36196.5 37203.8 38093.4 38145.0 38693.8 29961.7 32295.5 32359.5 32508.7 32561.7 24574.6 25211.0 25418.9 25429.7 25707.0 12:14:04 INFO - 2015-11-23 12:14:04,744 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,744 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:40692.01 Median:2183.23 stddev:126853.69 (5810.4%) stddev-sans-first:127173.40 12:14:04 INFO - 2015-11-23 12:14:04,745 DEBUG : BROWSER_OUTPUT: Values: 359.8 362.2 362.6 370.5 374.7 15137.9 17911.9 19854.3 20616.6 20914.0 22095.7 22105.1 22453.0 22550.7 22552.5 4673.8 6525.1 6684.7 6693.4 6699.0 4822.4 5335.8 7495.9 7505.2 7516.5 7201.1 7475.4 7486.6 7506.8 7509.1 6423.3 7353.6 7516.2 7530.9 7557.1 7142.4 7161.6 7165.4 7174.0 7175.0 24319.4 27544.9 27886.7 28495.0 28626.0 2174.6 2191.9 2199.0 2226.0 2489.2 15303.0 15484.1 15688.0 15773.4 16093.6 1814.5 1816.3 1848.3 1866.5 1867.4 99765.0 101344.5 108363.5 110662.0 116577.0 10780.8 11111.8 11121.5 11165.2 11194.6 13263.8 13264.7 13287.2 13293.2 13323.9 8469.5 8551.4 8566.2 8632.7 8645.8 8737.3 8741.9 8748.6 8825.2 8839.9 3858.8 3942.1 3959.1 4290.2 8520.5 2838.3 2921.3 3375.3 3421.5 3423.3 840.5 901.9 955.3 1007.8 1015.6 20445.6 20802.0 20807.0 20818.6 20964.5 911.2 952.5 956.0 1016.8 1037.7 11185.4 11528.6 11543.4 11545.7 11554.9 752914.0 756835.0 769907.0 778416.0 793335.0 123941.0 127247.0 131246.7 132282.3 137337.3 1047.6 1064.5 1168.3 1179.1 1183.1 18725.4 18845.9 19000.9 19012.1 19082.0 53869.2 54418.7 54632.0 54939.7 55201.7 70309.0 73320.6 74232.0 76046.6 78306.6 9830.8 9834.1 10115.4 10117.8 10120.1 14858.7 15187.8 17935.5 19619.7 20194.4 15939.8 16028.0 16056.8 16156.8 16238.0 15366.5 15522.5 15636.8 15748.1 16074.0 16196.1 16358.3 16405.0 16461.6 16667.6 9806.3 10021.3 10070.2 10169.9 10205.7 10423.1 13263.4 16155.5 16515.2 16535.8 12:14:04 INFO - 2015-11-23 12:14:04,745 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,745 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5819.36 Median:6224.58 stddev:3031.07 (48.7%) stddev-sans-first:3022.98 12:14:04 INFO - 2015-11-23 12:14:04,747 DEBUG : BROWSER_OUTPUT: Values: 1599.8 1616.3 1691.1 1911.8 2030.9 7507.1 7885.8 7914.0 7936.2 8034.0 8064.8 8190.5 8241.3 8266.8 8267.8 2147.5 2375.2 2394.4 2394.8 2398.3 2204.3 2205.1 2386.9 2410.4 2413.3 2340.7 2380.5 2387.4 2393.8 2393.8 2144.1 2188.5 2381.8 2416.1 2417.8 2188.3 2334.1 2384.1 2385.7 2386.8 8204.4 8438.1 8457.3 8469.5 8471.1 4325.5 5247.6 5286.7 5287.0 5295.7 3491.7 3496.7 3512.7 3564.6 3586.5 883.2 1018.9 1023.6 1061.1 1063.1 11134.0 11147.8 11152.2 11169.1 11184.8 4613.4 4670.7 4733.2 4755.2 4771.3 9713.1 9756.5 9765.7 9778.1 9781.5 5244.5 5247.9 5268.4 5268.9 5272.6 4785.7 4806.0 4821.0 4823.8 4828.2 3825.9 3882.5 3894.7 3918.7 3934.4 1262.3 1292.8 1298.9 1307.3 1309.3 1353.0 1369.7 1375.5 1398.6 1419.4 7762.2 7941.6 7945.8 7947.0 7952.6 501.8 505.2 509.5 511.1 514.7 5795.7 5920.9 5921.1 6158.8 6290.4 9871.8 9917.2 9960.5 10185.1 10218.3 9794.9 9815.7 9884.9 9898.7 9901.6 7686.5 7883.3 7961.7 7965.3 7980.1 7779.4 7923.4 7933.1 7936.8 7943.2 8872.6 8992.6 9076.5 9092.7 9238.1 9271.9 9424.7 9512.4 9513.0 9522.5 7303.6 7392.6 7394.6 7404.2 7424.3 7743.4 8002.0 8050.1 8053.4 8061.6 5852.1 6937.9 7422.0 7454.1 7581.8 7234.0 7358.5 7424.0 7463.3 7487.9 7513.0 7521.9 7536.1 7536.3 7551.2 6790.0 6830.3 6838.6 6861.5 6884.3 6341.7 6955.3 6992.6 7002.3 7014.4 12:14:04 INFO - 2015-11-23 12:14:04,747 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,747 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6050.74 Median:6909.93 stddev:1939.19 (28.1%) stddev-sans-first:1896.37 12:14:04 INFO - 2015-11-23 12:14:04,748 DEBUG : BROWSER_OUTPUT: Values: 322.5 331.9 332.2 339.0 342.6 6900.4 6903.5 6915.4 7025.7 7033.9 6643.9 6742.4 6830.8 6831.1 6966.1 5097.6 5156.1 5179.4 5183.3 5193.6 4152.8 5148.3 5152.3 5154.4 5179.8 3863.9 4816.7 4909.9 4945.7 4985.2 5010.1 5083.9 5098.9 5106.5 5107.1 4338.5 4341.2 4342.4 4353.0 4357.1 6607.8 6609.1 6633.9 6645.1 6653.1 5855.3 5989.7 5991.3 5993.4 6028.3 7416.0 7419.8 7421.6 7430.5 7434.1 4884.5 4888.8 4896.4 4905.5 4909.7 7645.8 7794.5 7831.5 7861.1 7887.7 4951.2 4961.6 4967.1 4967.6 4973.5 5051.2 5054.7 5061.9 5070.5 5074.1 4382.7 5053.1 5845.4 6046.0 6053.0 6399.0 7129.0 7455.9 7458.9 7467.3 1733.5 1750.5 1759.2 1759.3 1759.8 1066.3 1080.6 1090.3 1135.3 1156.0 6834.6 6906.9 6913.0 6934.7 7005.6 7801.6 7813.5 7829.6 7836.0 7837.7 6731.5 7003.1 7003.8 7005.9 7006.7 4083.6 4104.7 4124.6 4126.3 4132.6 7793.3 7827.3 7834.3 7840.5 7854.3 7862.6 8037.9 8100.7 8109.3 8112.6 7830.9 7860.1 7864.9 7867.8 7870.8 7528.8 7782.0 7791.6 7800.6 7804.7 6164.4 7641.9 7645.5 7654.7 7660.1 7791.2 7799.3 7828.0 7829.8 7832.0 4670.6 4745.9 4796.5 4838.3 4844.6 7672.2 7698.5 7704.3 7712.0 7713.1 7344.3 7358.4 7377.2 7381.6 7382.3 7075.3 7327.3 7328.7 7343.0 7357.5 7004.2 7131.6 7188.2 7189.3 7201.9 6937.8 7284.3 7329.2 7338.5 7339.7 7231.0 7232.6 7239.4 7243.2 7245.1 12:14:04 INFO - 2015-11-23 12:14:04,748 DEBUG : BROWSER_OUTPUT: 12:14:04 INFO - 2015-11-23 12:14:04,748 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18047.77 Median:51956.98 stddev:25497.59 (49.1%) stddev-sans-first:25536.00 12:14:04 INFO - 2015-11-23 12:14:04,749 DEBUG : BROWSER_OUTPUT: Values: 741.4 785.4 797.5 831.6 845.4 15040.7 15413.5 15427.7 15430.6 15440.5 13788.0 13842.4 13971.2 14380.0 14662.3 951.6 973.5 977.5 979.0 981.6 959.7 969.9 972.9 973.6 976.0 1022.7 1034.2 1037.7 1038.5 1040.6 1021.4 1028.0 1028.2 1030.2 1030.7 758.2 760.3 760.3 761.3 761.8 13250.0 13372.0 13426.4 13435.5 13478.0 11038.9 11050.3 11061.9 11143.2 11149.0 9514.1 9521.1 9653.6 9690.5 10020.9 3240.2 3285.1 3289.6 3315.2 3332.7 63612.3 74753.5 75960.9 76546.0 80384.6 8866.8 9496.2 9638.5 9670.0 9775.2 21691.0 21741.5 21765.7 21779.1 23001.0 7449.1 7595.1 7672.5 7778.8 7783.3 3992.4 4041.8 4055.8 4062.5 4070.3 3661.7 3703.9 3706.0 3713.2 3715.0 630.8 649.4 650.1 672.3 672.9 480.6 487.2 489.1 513.0 514.1 7860.4 8221.3 8262.8 8357.2 8484.2 511.3 601.6 617.1 617.6 621.2 3669.4 3975.4 4058.8 4233.3 4285.5 94241.6 95253.0 95832.5 98309.5 99452.5 72594.2 75879.6 82853.6 84290.6 85007.6 59110.0 74586.0 75090.0 75992.5 76416.6 8651.4 8777.8 8802.6 8942.5 9028.0 44092.9 51114.7 51912.5 52001.5 53380.0 41113.8 59854.7 61403.4 61410.0 61749.7 11267.3 11277.7 11306.8 11387.8 11611.4 10866.7 11916.7 12526.8 12550.3 13332.3 11089.3 11312.7 11513.6 11715.0 12432.7 11303.0 11491.8 11615.9 11625.6 12254.6 11047.7 11107.3 11248.2 11454.5 11991.3 8703.8 8805.6 9020.7 9410.7 9496.8 8854.0 8895.4 9106.5 9716.7 9880.4 12:14:04 INFO - 2015-11-23 12:14:04,750 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:14:04 INFO - 2015-11-23 12:14:04,750 DEBUG : BROWSER_OUTPUT: 12:14:05 INFO - 2015-11-23 12:14:05,168 INFO : Browser exited with error code: 0 12:14:05 INFO - 2015-11-23 12:14:05,193 INFO : Completed test dromaeo_css (00:18:33) 12:14:05 INFO - 2015-11-23 12:14:05,193 INFO : Starting test kraken 12:14:05 INFO - 2015-11-23 12:14:05,193 DEBUG : operating with platform_type : mac_ 12:14:05 INFO - 2015-11-23 12:14:05,194 INFO : Initialising browser for kraken test... 12:14:05 INFO - 2015-11-23 12:14:05,205 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp08OtxX/profile http://localhost:49533/getInfo.html 12:14:07 INFO - 2015-11-23 12:14:07,379 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:14:07 INFO - 2015-11-23 12:14:07,379 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:14:07 INFO - 2015-11-23 12:14:07,379 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:14:07 INFO - 2015-11-23 12:14:07,379 DEBUG : BROWSER_OUTPUT: __metrics 12:14:07 INFO - 2015-11-23 12:14:07,397 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:08 INFO - 2015-11-23 12:14:08,066 INFO : Browser initialized. 12:14:08 INFO - 2015-11-23 12:14:08,067 INFO : Running cycle 1/1 for kraken test... 12:14:08 INFO - 2015-11-23 12:14:08,067 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp08OtxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:14:19 INFO - 2015-11-23 12:14:19,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 226238464 12:14:19 INFO - 2015-11-23 12:14:19,983 DEBUG : BROWSER_OUTPUT: 12:14:22 INFO - 2015-11-23 12:14:22,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:23 INFO - 2015-11-23 12:14:23,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 275394560 12:14:23 INFO - 2015-11-23 12:14:23,074 DEBUG : BROWSER_OUTPUT: 12:14:25 INFO - 2015-11-23 12:14:25,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-dft) 12:14:26 INFO - 2015-11-23 12:14:26,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 290983936 12:14:26 INFO - 2015-11-23 12:14:26,181 DEBUG : BROWSER_OUTPUT: 12:14:29 INFO - 2015-11-23 12:14:29,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-fft) 12:14:30 INFO - 2015-11-23 12:14:30,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 277331968 12:14:30 INFO - 2015-11-23 12:14:30,062 DEBUG : BROWSER_OUTPUT: 12:14:31 INFO - 2015-11-23 12:14:31,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-oscillator) 12:14:32 INFO - 2015-11-23 12:14:32,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 278319104 12:14:32 INFO - 2015-11-23 12:14:32,476 DEBUG : BROWSER_OUTPUT: 12:14:34 INFO - 2015-11-23 12:14:34,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:14:35 INFO - 2015-11-23 12:14:35,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 280834048 12:14:35 INFO - 2015-11-23 12:14:35,200 DEBUG : BROWSER_OUTPUT: 12:14:37 INFO - 2015-11-23 12:14:37,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-darkroom) 12:14:38 INFO - 2015-11-23 12:14:38,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 282214400 12:14:38 INFO - 2015-11-23 12:14:38,460 DEBUG : BROWSER_OUTPUT: 12:14:41 INFO - 2015-11-23 12:14:41,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:41 INFO - 2015-11-23 12:14:41,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 282202112 12:14:41 INFO - 2015-11-23 12:14:41,993 DEBUG : BROWSER_OUTPUT: 12:14:44 INFO - 2015-11-23 12:14:44,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49533/tests/kraken/driver.html?testName=json-parse-financial) 12:14:45 INFO - 2015-11-23 12:14:45,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 281440256 12:14:45 INFO - 2015-11-23 12:14:45,470 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:47 INFO - 2015-11-23 12:14:47,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 317227008 12:14:47 INFO - 2015-11-23 12:14:47,544 DEBUG : BROWSER_OUTPUT: 12:14:49 INFO - 2015-11-23 12:14:49,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:49 INFO - 2015-11-23 12:14:49,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 317628416 12:14:49 INFO - 2015-11-23 12:14:49,934 DEBUG : BROWSER_OUTPUT: 12:14:52 INFO - 2015-11-23 12:14:52,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:52 INFO - 2015-11-23 12:14:52,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 322752512 12:14:52 INFO - 2015-11-23 12:14:52,618 DEBUG : BROWSER_OUTPUT: 12:14:55 INFO - 2015-11-23 12:14:55,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:55 INFO - 2015-11-23 12:14:55,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 325316608 12:14:55 INFO - 2015-11-23 12:14:55,739 DEBUG : BROWSER_OUTPUT: 12:14:58 INFO - 2015-11-23 12:14:58,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:58 INFO - 2015-11-23 12:14:58,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 322981888 12:14:58 INFO - 2015-11-23 12:14:58,847 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49533/tests/kraken/driver.html?testName=ai-astar) 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 382824448 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;102;110;109;110;99;111;102;110 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;145;156;119;138;112;151;141;117 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;182;186;180;181;207;262;186;184;173 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;69;72;72;56;57;56;68;72;54 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;83;117;75;75;74;115;110;111;146 12:15:00 INFO - 2015-11-23 12:15:00,741 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;86;84;86;85;84;85;89;85;84 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;102;143;95;93;91;118;150;93;94;93 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;86;86;107;141;144;86;88;85;86;84 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;54;54;53;53;54;54;62;53;52 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;65;65;66;66;65;66;67 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;80;83;82;82;82;82;82;106;109 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;122;128;121;130;120;124;121;124;120 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;178;170;134;134;136;127;138;134;137;123 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;64;66;66;64;66;67;64;65 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1025 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309700735__endTimestamp 12:15:00 INFO - 2015-11-23 12:15:00,742 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:110.00 stddev:4.39 (4.0%) stddev-sans-first:4.61 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 102.0 110.0 109.0 110.0 99.0 111.0 102.0 110.0 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.40 Median:143.00 stddev:16.08 (11.2%) stddev-sans-first:16.03 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 145.0 156.0 119.0 138.0 112.0 151.0 141.0 117.0 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:192.20 Median:185.00 stddev:26.05 (14.1%) stddev-sans-first:27.31 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: Values: 181.0 182.0 186.0 180.0 181.0 207.0 262.0 186.0 184.0 173.0 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.90 Median:68.50 stddev:7.53 (11.0%) stddev-sans-first:7.98 12:15:00 INFO - 2015-11-23 12:15:00,743 DEBUG : BROWSER_OUTPUT: Values: 63.0 69.0 72.0 72.0 56.0 57.0 56.0 68.0 72.0 54.0 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:99.10 Median:74.50 stddev:24.23 (32.5%) stddev-sans-first:25.15 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 117.0 75.0 75.0 74.0 115.0 110.0 111.0 146.0 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:85.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 84.0 86.0 85.0 84.0 85.0 89.0 85.0 84.0 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:107.20 Median:93.00 stddev:22.23 (23.9%) stddev-sans-first:23.50 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: Values: 102.0 143.0 95.0 93.0 91.0 118.0 150.0 93.0 94.0 93.0 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:99.30 Median:86.00 stddev:23.73 (27.6%) stddev-sans-first:24.68 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 107.0 141.0 144.0 86.0 88.0 85.0 86.0 84.0 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:2.91 (5.4%) stddev-sans-first:2.96 12:15:00 INFO - 2015-11-23 12:15:00,744 DEBUG : BROWSER_OUTPUT: Values: 57.0 54.0 54.0 53.0 53.0 54.0 54.0 62.0 53.0 52.0 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.50 stddev:1.33 (2.0%) stddev-sans-first:1.20 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 65.0 65.0 66.0 66.0 65.0 66.0 67.0 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:82.00 stddev:10.81 (13.2%) stddev-sans-first:11.36 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: Values: 83.0 80.0 83.0 82.0 82.0 82.0 82.0 82.0 106.0 109.0 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:124.00 stddev:3.81 (3.1%) stddev-sans-first:3.57 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: Values: 129.0 122.0 128.0 121.0 130.0 120.0 124.0 121.0 124.0 120.0 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:136.50 stddev:18.03 (13.2%) stddev-sans-first:13.29 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: Values: 178.0 170.0 134.0 134.0 136.0 127.0 138.0 134.0 137.0 123.0 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: 12:15:00 INFO - 2015-11-23 12:15:00,745 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:1.29 (2.0%) stddev-sans-first:1.17 12:15:00 INFO - 2015-11-23 12:15:00,746 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 66.0 66.0 64.0 66.0 67.0 64.0 65.0 12:15:00 INFO - 2015-11-23 12:15:00,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:15:00 INFO - 2015-11-23 12:15:00,746 DEBUG : BROWSER_OUTPUT: 12:15:01 INFO - 2015-11-23 12:15:01,372 INFO : Browser exited with error code: 0 12:15:01 INFO - 2015-11-23 12:15:01,416 INFO : Completed test kraken (00:00:56) 12:15:01 INFO - 2015-11-23 12:15:01,416 INFO : Starting test v8_7 12:15:01 INFO - 2015-11-23 12:15:01,416 DEBUG : operating with platform_type : mac_ 12:15:01 INFO - 2015-11-23 12:15:01,416 INFO : Initialising browser for v8_7 test... 12:15:01 INFO - 2015-11-23 12:15:01,428 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpddsKPC/profile http://localhost:49533/getInfo.html 12:15:03 INFO - 2015-11-23 12:15:03,532 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:15:03 INFO - 2015-11-23 12:15:03,532 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:15:03 INFO - 2015-11-23 12:15:03,532 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:15:03 INFO - 2015-11-23 12:15:03,532 DEBUG : BROWSER_OUTPUT: __metrics 12:15:03 INFO - 2015-11-23 12:15:03,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:04 INFO - 2015-11-23 12:15:04,179 INFO : Browser initialized. 12:15:04 INFO - 2015-11-23 12:15:04,179 INFO : Running cycle 1/1 for v8_7 test... 12:15:04 INFO - 2015-11-23 12:15:04,179 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpddsKPC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:15:16 INFO - 2015-11-23 12:15:16,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 226197504 12:15:16 INFO - 2015-11-23 12:15:16,052 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49533/tests/v8_7/run.html (next: http://localhost:49533/tests/v8_7/run.html) 12:15:38 INFO - 2015-11-23 12:15:38,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 720687104 12:15:38 INFO - 2015-11-23 12:15:38,874 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |0;Richards;146.7351430667645 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.61676839061997 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4686.915887850468 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1712.3287671232877 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |6;Boyer;12469.135802469136 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |7;RegExp;30969.696969696968 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |8;Splay;646.2628865979382 12:15:38 INFO - 2015-11-23 12:15:38,875 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309738866__endTimestamp 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.74 Median:146.74 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: Values: 146.7 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.62 Median:160.62 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: Values: 160.6 12:15:38 INFO - 2015-11-23 12:15:38,876 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: Values: 277.6 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4686.92 Median:4686.92 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: Values: 4686.9 12:15:38 INFO - 2015-11-23 12:15:38,877 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1712.33 Median:1712.33 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: Values: 1712.3 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: Values: 786.8 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12469.14 Median:12469.14 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: Values: 12469.1 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30969.70 Median:30969.70 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: Values: 30969.7 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,878 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.26 Median:646.26 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: Values: 646.3 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: Values: 4513.5 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:15:38 INFO - 2015-11-23 12:15:38,879 DEBUG : BROWSER_OUTPUT: 12:15:39 INFO - 2015-11-23 12:15:39,542 INFO : Browser exited with error code: 0 12:15:39 INFO - 2015-11-23 12:15:39,560 INFO : Completed test v8_7 (00:00:38) 12:15:39 INFO - 2015-11-23 12:15:39,812 INFO : Completed test suite (00:20:08) 12:15:39 INFO - 2015-11-23 12:15:39,812 DEBUG : Working with test: dromaeo_css 12:15:39 INFO - 2015-11-23 12:15:39,812 DEBUG : Generating results file: dromaeo_css 12:15:39 INFO - 2015-11-23 12:15:39,813 DEBUG : Working with test: kraken 12:15:39 INFO - 2015-11-23 12:15:39,813 DEBUG : Generating results file: kraken 12:15:39 INFO - 2015-11-23 12:15:39,813 INFO : javascript benchmark 12:15:39 INFO - 2015-11-23 12:15:39,813 DEBUG : Working with test: v8_7 12:15:39 INFO - 2015-11-23 12:15:39,813 DEBUG : Generating results file: v8_7 12:15:39 INFO - 2015-11-23 12:15:39,814 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:40 INFO - 2015-11-23 12:15:40,319 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:15:40 INFO - 2015-11-23 12:15:40,319 DEBUG : process_Request line: dromaeo_css 7815.60 graph.html#tests=[[72,64,59]] 12:15:40 INFO - 2015-11-23 12:15:40,319 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:40 INFO - 2015-11-23 12:15:40,431 DEBUG : process_Request line: kraken 1426.20 graph.html#tests=[[232,64,59]] 12:15:40 INFO - 2015-11-23 12:15:40,431 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:40 INFO - 2015-11-23 12:15:40,544 DEBUG : process_Request line: v8_7 20550.10 graph.html#tests=[[230,64,59]] 12:15:40 INFO - 2015-11-23 12:15:40,545 INFO : javascript benchmark 12:15:40 INFO - 2015-11-23 12:15:40,547 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3484.6166921638624, 3544.6809787119155, 3566.179778650912, 3567.5362202913616, 3587.2108136210027, 5781.653100813944, 5903.114532820068, 5932.851678708034, 6078.300995385532, 6093.817185484431, 5945.286565612122, 5950.55370847186, 5992.640441573509, 6082.4221698938645, 6105.511559075275, 5366.168243922199, 5417.26866872973, 5427.348718153827, 5437.8368648940395, 5458.808941687042, 5560.277163968678, 5566.276384070065, 5575.135853942646, 5576.609637325369, 5594.412586678402, 4615.192341340269, 5237.47625237477, 5327.0, 5384.865378365533, 5550.306211723514, 4982.227754698028, 4986.975065124688, 5415.10650742627, 5431.158170483542, 5450.836474905759, 5305.071612467841, 5396.0, 5412.648177868426, 5413.621046526745, 5416.91874621881, 4592.678512504126, 5872.383399743051, 5878.676672783038, 5878.883012227663, 5882.911756323659, 6302.338254483259, 6327.4938004959495, 6329.683515824237, 6339.429451349354, 6390.55266131371, 6395.264544577387, 6467.353264673495, 6472.9029064564065, 6484.124643173205, 6507.837304067389, 6178.938210617926, 6183.443490085914, 6193.969030154865, 6201.410865967726, 6201.6899155042065, 6287.591306565058, 6398.264199617103, 6422.903656445157, 6474.255460621995, 6605.438537724252, 5261.237120617489, 6332.366763323631, 6354.682265886687, 6368.872622547523, 6381.0, 6459.806205813833, 6461.838454038592, 6463.192100987377, 6477.319881412478, 6489.870202595922, 6169.660668663177, 6320.494360451153, 6329.778457753957, 6353.459955903708, 6367.4906007519285, 6245.0, 6324.114623952651, 6332.461740752087, 6335.11308416822, 6343.0, 5126.051680439131, 5147.948520514822, 5149.2791009258735, 5152.252923326097, 5171.612129090333, 4516.299973504112, 4593.977030114828, 4602.976985115053, 4636.327732478771, 4654.581087702123, 5968.7015649217365, 6089.629833287563, 6097.359777223416, 6104.511639068864, 6117.401149625483, 6421.8073457796345, 6431.421172094534, 6459.741610335534, 6460.160179176677, 6468.450181734511, 5862.589618726648, 5985.730642121115, 6008.699565021819, 6084.665343406155, 6091.208142941389, 5401.675899446046, 5466.480684334982, 5478.04134276508, 5502.944970550323, 5521.641093329001, 6380.330065343072, 6457.321981191907, 6459.580127291711, 6467.773627923, 6468.676566171673, 6169.691515424301, 6434.647488893744, 6490.643014634241, 6492.091107245084, 6499.3175716549085, 6287.245530536182, 6349.68251587428, 6370.076338930921, 6421.133147025092, 6467.547271690936, 6368.9044664330995, 6386.233651961795, 6386.776462823779, 6390.872182556416, 6398.296187419473, 5589.049861523632, 6419.069234960998, 6478.546501744832, 6494.837629059311, 6497.9025314619375, 6129.847850912788, 6143.078538219303, 6231.376862313732, 6277.466415354564, 6296.811095667137, 6267.122602835698, 6282.465990390868, 6310.242770867525, 6312.747490100528, 6316.778912738032, 5383.434739352469, 6115.785947491817, 6267.9373206267355, 6270.529710271657, 6279.560430769802, 4541.978054937613, 6170.352113028068, 6275.184226050585, 6277.027060805583, 6290.308066112632, 6204.968975155095, 6249.625022498664, 6283.748650053946, 6293.55945083858, 6301.149344838388], "unit": "ms", "name": "dojo.html", "value": 5872.653088127314}, {"lowerIsBetter": false, "replicates": [551.2943432406521, 585.122316525212, 593.8366949089, 620.2587907450595, 632.1245075570336, 23919.880400597995, 41788.37317440241, 41934.58065419345, 41944.58055419445, 42090.57909420909, 44696.3295550567, 45099.0, 45100.3234951476, 45314.7734261329, 45325.32012019822, 8520.318374530054, 8852.911470885274, 8894.843670322849, 9785.363951343175, 10035.69892903214, 8747.343949203803, 12129.272243665364, 12287.877121228763, 12302.200356976813, 12330.876691233063, 12039.398030098504, 12146.089043321743, 12154.453049612788, 12157.756844863097, 12170.026397888192, 9006.0, 9109.043550427175, 9124.635014599407, 11974.880251197506, 12090.879091209152, 11890.762184756342, 12013.759724805543, 12041.277523348626, 12053.276803391824, 12062.517499300018, 40932.0, 41260.79369603163, 41308.0, 41330.0, 41411.1717765643, 3268.9866141495972, 3293.75296852737, 3319.3859136059664, 3561.7684850484893, 3841.3277676406797, 29377.706222937926, 29663.703362966527, 30009.849950750326, 30331.545026824617, 30517.69482305193, 2698.9595156072673, 2766.239284196862, 2772.099067802952, 2772.279207406069, 2801.1176479409123, 504788.476057621, 506423.0, 506568.0, 507035.0, 507349.0, 48935.0, 70257.64871175612, 70951.2904870955, 70982.0, 71064.0, 68377.65811171012, 68801.3119868805, 69089.0, 69412.61174776476, 69462.0, 16736.0, 16913.7462938056, 16935.068571228454, 16978.06620635877, 16994.660106797794, 12808.551700690432, 13093.0, 13111.0, 13112.278824664734, 13117.803232951514, 16638.50084497467, 20369.490762730755, 20411.285605003755, 20429.284975025803, 20489.38531844047, 8642.0, 8808.823823523493, 8815.074417186102, 8853.69012084574, 8861.335399845037, 804.3685706720197, 927.4342650982895, 953.6900507335143, 953.7949340891603, 1105.1876870500175, 27437.0, 27978.72021279802, 28116.437671246462, 28374.290642734097, 28543.0, 1020.8162530744389, 1085.1210519479089, 1183.148133343991, 1197.7484728207, 1209.5524655877382, 14152.787708184385, 14904.627384315261, 14906.403743850342, 14926.328315225841, 14940.477083302032, 548384.0, 554986.0, 555068.0, 555402.0, 556168.0, 60316.698416508516, 60461.39538604557, 60622.0, 60673.69663151656, 60803.0, 1342.2013901728455, 1440.9135451872921, 1456.410153887677, 1461.8099647045815, 1470.9338079786435, 25423.872880635477, 29455.55816662709, 30582.541261880644, 30653.0, 30858.0, 49520.257196142804, 49547.50452495573, 49586.25620615766, 49616.255756162966, 50036.24945625746, 492604.0, 503672.0, 543022.5697742972, 551404.2429787825, 553509.0, 30156.849215754657, 30177.698223018368, 30365.848170759004, 30373.088807335815, 30410.543841841947, 42041.57958420377, 42506.36240456458, 42510.1497970045, 43051.56948430475, 43686.34470483009, 34094.31811363709, 35502.11244718903, 35696.821515892254, 36507.452388213664, 36535.0, 32255.0, 36218.0, 36284.63715362812, 37065.629343707296, 37908.43137352887, 36196.45705314475, 37203.813980929925, 38093.4285985716, 38145.0, 38693.806530967166, 29961.700382995892, 32295.51556726604, 32359.51460728044, 32508.674913250565, 32561.674383255864, 24574.63138052895, 25210.99156033738, 25418.872905635355, 25429.72851357388, 25706.971721130943], "unit": "ms", "name": "ext.html", "value": 20420.89622939889}, {"lowerIsBetter": false, "replicates": [359.83627449510476, 362.235682709483, 362.5649220934879, 370.5312779334142, 374.67029014467266, 15137.924310378432, 17911.910440447813, 19854.305099321507, 20616.587668246644, 20914.0, 22095.66856497154, 22105.115795368165, 22453.0, 22550.661740073912, 22552.54894902105, 4673.76631168442, 6525.119108920294, 6684.732610695566, 6693.364130407628, 6698.966505167467, 4822.445418776851, 5335.813246536372, 7495.925040749605, 7505.174430812606, 7516.473846830724, 7201.099862517185, 7475.401967842587, 7486.588237646927, 7506.774796756106, 7509.098908131032, 6423.261324947621, 7353.595552244625, 7516.173220945691, 7530.887036694481, 7557.130929943044, 7142.4286057115305, 7161.606111663857, 7165.390941769956, 7174.0, 7174.964125179341, 24319.392015199763, 27544.862275688694, 27886.745096470706, 28495.0, 28626.0, 2174.597699425611, 2191.854688521976, 2198.9890050549807, 2225.9666105008437, 2489.2283392148493, 15303.005304655162, 15484.070955742578, 15688.0, 15773.369065237377, 16093.597660058593, 1814.4828723813782, 1816.2553353125288, 1848.334599544163, 1866.542697039234, 1867.449102514748, 99765.0, 101344.49327753388, 108363.45818270936, 110662.0, 116577.0, 10780.784384312426, 11111.83332250017, 11121.499532521057, 11165.218434709492, 11194.552217911356, 13263.801042984363, 13264.668383290302, 13287.20276783396, 13293.20240785556, 13323.93338033323, 8469.491830490191, 8551.444156129955, 8566.186212309945, 8632.654693812177, 8645.827083458296, 8737.30101591871, 8741.912580874237, 8748.56257187151, 8825.161609647073, 8839.911600884037, 3858.8456461741216, 3942.1327307992196, 3959.109200429938, 4290.249206388869, 8520.488770673779, 2838.303611569018, 2921.3134913295785, 3375.2574433624563, 3421.5038819371052, 3423.3495635829113, 840.5083026429485, 901.8827552418144, 955.2739917662487, 1007.8185926533148, 1015.5633077776627, 20445.591088178153, 20802.0, 20807.0, 20818.58362832765, 20964.47588810292, 911.1708345405782, 952.5142177489391, 955.9808803824023, 1016.8423894296396, 1037.6783197208738, 11185.440727963569, 11528.596499122657, 11543.36511491876, 11545.711357215969, 11554.884451155549, 752914.0, 756835.0, 769907.0, 778416.0, 793335.0333248297, 123941.0, 127247.0, 131246.68753312537, 132282.33858830837, 137337.3133134328, 1047.607147319755, 1064.5156453813652, 1168.3223730236443, 1179.1451197881638, 1183.1303991566192, 18725.438236852915, 18845.90577047106, 19000.904995474935, 19012.144453499903, 19081.950492723034, 53869.19196212138, 54418.72790636022, 54632.0, 54939.72530137324, 55201.72399137979, 70309.0, 73320.63339683268, 74232.0, 76046.61976690081, 78306.6084669573, 9830.75423114428, 9834.065763752433, 10115.39307641544, 10117.848232276669, 10120.139788118093, 14858.702825943205, 15187.848121518644, 17935.461936141935, 19619.70570441473, 20194.39416817498, 15939.840601593836, 16028.0, 16056.839431605535, 16156.838431615533, 16238.025718456931, 15366.463353664543, 15522.456714014956, 15636.765448518508, 15748.133852638215, 16074.035557866566, 16196.109213993344, 16358.263878125275, 16405.0, 16461.58846028811, 16667.583310417336, 9806.313558050868, 10021.298509104292, 10070.194384449373, 10169.9491502542, 10205.744856378353, 10423.11403530678, 13263.403146858607, 16155.515334539983, 16515.17424128813, 16535.751963720795], "unit": "ms", "name": "jquery.html", "value": 10813.642522077569}, {"lowerIsBetter": false, "replicates": [1599.8000249968754, 1616.2726772952174, 1691.1290685297067, 1911.7573577174835, 2030.857839951204, 7507.099148102228, 7885.763427097189, 7914.0, 7936.246056624625, 8033.959830200841, 8064.798380040487, 8190.508569485835, 8241.258286754191, 8266.83466330673, 8267.793305167374, 2147.5382792699565, 2375.1924345722496, 2394.413368724665, 2394.784469397754, 2398.292503711409, 2204.2836078274545, 2205.0628482894786, 2386.904523819054, 2410.4214988402746, 2413.3001429585397, 2340.6957095577636, 2380.4762952150586, 2387.415083304593, 2393.772591603795, 2393.8444001139956, 2144.0994782191515, 2188.540406514634, 2381.809455243585, 2416.0577374823833, 2417.8428402153804, 2188.2888061380113, 2334.124703236286, 2384.0821283805685, 2385.7256415512265, 2386.809055275591, 8204.425690201688, 8438.11399803018, 8457.323414126917, 8469.49183049013, 8471.110533394029, 4325.52419233884, 5247.606429517801, 5286.65636733615, 5286.973565132188, 5295.655782374133, 3491.6508349165133, 3496.7202623790035, 3512.7189824813954, 3564.554430696163, 3586.5337506124297, 883.231588517987, 1018.9337693050002, 1023.626376372626, 1061.0662616897082, 1063.0751246415668, 11133.997940185422, 11147.777044459146, 11152.219344645879, 11169.106471482262, 11184.776304473866, 4613.423322084739, 4670.673052886334, 4733.242681171065, 4755.167845627071, 4771.33201351811, 9713.07725766051, 9756.46339451337, 9765.658201962897, 9778.119969202806, 9781.510924453749, 5244.501772331699, 5247.868803279872, 5268.367795864444, 5268.868278292996, 5272.578193744491, 4785.712857228577, 4805.951940480551, 4821.0, 4823.782929768169, 4828.203346447867, 3825.9426108608395, 3882.514685664292, 3894.7078969076865, 3918.686505079587, 3934.449177115206, 1262.2552693910636, 1292.7673018856508, 1298.9350532473338, 1307.3136603283353, 1309.3387839141174, 1353.0325817040864, 1369.698666293414, 1375.5116933488468, 1398.6223719595855, 1419.3825685826698, 7762.184970578121, 7941.6029198539845, 7945.8410831784195, 7947.0, 7952.562609056557, 501.81182056728727, 505.2118694835994, 509.4828748819951, 511.0826067209294, 514.6989011428357, 5795.739191736382, 5920.851978700567, 5921.141434491975, 6158.784442544489, 6290.370962903673, 9871.753206169904, 9917.15704165154, 9960.452175130438, 10185.134263587677, 10218.335808172593, 9794.853077203848, 9815.705528834147, 9884.901150988542, 9898.653547125816, 9901.554430050664, 7686.46194766361, 7883.251091146332, 7961.681532738626, 7965.322947549524, 7980.122186559473, 7779.37764978789, 7923.366130709414, 7933.087694915159, 7936.761897143095, 7943.165967573322, 8872.600732966903, 8992.640294388151, 9076.455412675261, 9092.681756138503, 9238.122378374044, 9271.907280927375, 9424.670136545188, 9512.429254244767, 9513.0, 9522.476263805556, 7303.634818259172, 7392.630368481662, 7394.630268486447, 7404.185539590749, 7424.257574242532, 7743.380529557509, 8002.0, 8050.114487406498, 8053.395995300493, 8061.637226324947, 5852.063669812809, 6937.89593156093, 7421.962890185515, 7454.142773581108, 7581.810454738455, 7234.0, 7358.521696089737, 7424.0348754661545, 7463.328300452985, 7487.887681684888, 7513.023306970059, 7521.887171692539, 7536.057992750906, 7536.321731044232, 7551.169371369035, 6790.049393084873, 6830.31696830313, 6838.589684618939, 6861.451083913175, 6884.345987131214, 6341.651209183539, 6955.269696681776, 6992.580445173306, 7002.299770023161, 7014.403775679124], "unit": "ms", "name": "mootools.html", "value": 4696.815094039971}, {"lowerIsBetter": false, "replicates": [322.4791960983012, 331.86061854021307, 332.247459504223, 339.0117806593781, 342.5803390846212, 6900.378965893075, 6903.516753827234, 6915.44676425886, 7025.683844227009, 7033.8593228135405, 6643.933560664404, 6742.393184613384, 6830.760923367683, 6831.146106736658, 6966.12923384577, 5097.643164978453, 5156.097682905495, 5179.352580927384, 5183.300254465656, 5193.58451323895, 4152.771597562133, 5148.253503242027, 5152.252923326116, 5154.355705536808, 5179.8446046618665, 3863.9227215455676, 4816.710997340153, 4909.901801963959, 4945.678530895499, 4985.1774457214515, 5010.073136469747, 5083.932374201422, 5098.9235161472425, 5106.514881086291, 5107.055194788976, 4338.544452832471, 4341.240282950471, 4342.413774140482, 4352.956470435319, 4357.106793107406, 6607.768728094542, 6609.1408116944485, 6633.93366066338, 6645.136132302818, 6653.101831252816, 5855.326637436664, 5989.700514974234, 5991.340952495222, 5993.4006599340155, 6028.276606807167, 7416.0, 7419.777406677808, 7421.628918554051, 7430.517016393917, 7434.070741157356, 4884.4871288514905, 4888.780004899752, 4896.387951506062, 4905.460399356068, 4909.68087074339, 7645.770626881203, 7794.493357931717, 7831.451798374116, 7861.135275119732, 7887.684492620346, 4951.183054795991, 4961.603071754251, 4967.056259310792, 4967.602591792648, 4973.452920178777, 5051.191809310566, 5054.69671819692, 5061.873453163626, 5070.4929507049, 5074.13739664258, 4382.737035777864, 5053.090443720165, 5845.386234445322, 6046.032634778502, 6053.0, 6398.976163813767, 7129.0, 7455.888161677579, 7458.888116678254, 7467.290607392289, 1733.4886208568503, 1750.5011071844463, 1759.1643969114568, 1759.3050744955672, 1759.81521940197, 1066.2962444786403, 1080.621782376162, 1090.2586241355955, 1135.2904434728296, 1156.0, 6834.624095674686, 6906.896396554056, 6912.965435172892, 6934.653267336714, 7005.614691192033, 7801.609919504002, 7813.4921230121, 7829.569373684388, 7835.960820195863, 7837.725679601187, 6731.49513786468, 7003.054587630707, 7003.7548685795755, 7005.894911576331, 7006.719731210695, 4083.591640835952, 4104.671626269891, 4124.608162224584, 4126.319157339006, 4132.648724858421, 7793.2596403341595, 7827.25641064098, 7834.294913457816, 7840.549498342711, 7854.332381747501, 7862.646180921873, 8037.919620803717, 8100.675972961016, 8109.270165685117, 8112.594370281462, 7830.921690783133, 7860.135385107634, 7864.882026769717, 7867.803304917423, 7870.763877083811, 7528.8494230116185, 7782.0, 7791.610419479117, 7800.570968596555, 7804.72683456099, 6164.383561643979, 7641.923580764344, 7645.541267523967, 7654.73208437702, 7660.080790305199, 7791.181925897926, 7799.298063174115, 7827.9608601956625, 7829.804254893673, 7831.960840195762, 4670.579647831712, 4745.9050818984115, 4796.496367881322, 4838.250071238823, 4844.588210002189, 7672.232776722283, 7698.499597526143, 7704.30661240491, 7712.035995500562, 7713.112992005991, 7344.30229128232, 7358.374538164316, 7377.1885092638695, 7381.594012329373, 7382.2617738225745, 7075.327843854826, 7327.2672732726305, 7328.743493977685, 7343.0, 7357.484976051625, 7004.229534751275, 7131.643417829192, 7188.160676532845, 7189.317014883578, 7201.855962880818, 6937.82655433598, 7284.344409003003, 7329.1937886833475, 7338.522996005243, 7339.74310899116, 7231.0, 7232.63836808168, 7239.420846332386, 7243.239459856639, 7245.094363204599], "unit": "ms", "name": "prototype.html", "value": 5397.550314240251}, {"lowerIsBetter": false, "replicates": [741.4216910809569, 785.3520845302627, 797.5175019113436, 831.6049876308753, 845.3575282785089, 15040.699186016287, 15413.537593872174, 15427.69144617107, 15430.61423464414, 15440.459583914566, 13788.034837561374, 13842.377093030813, 13971.16173029619, 14380.0, 14662.340194691238, 951.609839965616, 973.4548652754445, 977.5063592885583, 979.0356498848664, 981.5533932060931, 959.6545243712258, 969.9418034917892, 972.9124378805906, 973.6056896956744, 976.0093505092337, 1022.734089136826, 1034.1674951663908, 1037.704254287528, 1038.4911393417208, 1040.6357774778842, 1021.4024795494645, 1028.0387837372007, 1028.239103063735, 1030.2118879057527, 1030.7320096774893, 758.2114600815146, 760.2511526146741, 760.3461023519768, 761.3072104384983, 761.7943155348025, 13250.0, 13372.0, 13426.395812188475, 13435.462581496728, 13478.0, 11038.889611103947, 11050.33697978116, 11061.889381106246, 11143.219974601781, 11148.99014924784, 9514.143727064597, 9521.1107962595, 9653.565589548487, 9690.46702431366, 10020.949895250476, 3240.206149493389, 3285.1458620758535, 3289.5723555937575, 3315.154635567939, 3332.733381329512, 63612.303183455806, 74753.5049299011, 75960.86058709069, 76546.0, 80384.59807700982, 8866.758653788474, 9496.188513395962, 9638.518074096268, 9670.0, 9775.21798256152, 21691.0, 21741.456463588536, 21765.673514897288, 21779.128834846746, 23001.0, 7449.106107267163, 7595.050618672666, 7672.5012874163, 7778.766637000899, 7783.260590243918, 3992.4210989406374, 4041.8383264669674, 4055.7972101395403, 4062.4921884764403, 4070.3487442009136, 3661.707063434919, 3703.8888833335045, 3705.9814700926863, 3713.20166164276, 3714.9628503714616, 630.7855329188098, 649.3506493506494, 650.1353200243665, 672.277301900459, 672.8822456070168, 480.5746913981152, 487.1669445248594, 489.1244672037014, 512.9717865517358, 514.054140381692, 7860.410469214832, 8221.342292616577, 8262.8347433051, 8357.164283571594, 8484.207480430876, 511.3352641565949, 601.6342901613314, 617.0867116667357, 617.6016469377226, 621.2482895696168, 3669.43123815809, 3975.423563583322, 4058.837646494166, 4233.25917964355, 4285.528591854893, 94241.58637620442, 95253.0, 95832.52083739536, 98309.50845245727, 99452.50273748585, 72594.18514537073, 75879.62060189774, 82853.58573207095, 84290.57854710687, 85007.5749621248, 59110.0, 74586.0, 75090.0, 75992.48015039669, 76416.61791691007, 8651.394402391772, 8777.824443511221, 8802.64789408442, 8942.46345219289, 9027.954860225656, 44092.897677558314, 51114.74442627763, 51912.480875192276, 52001.479985199665, 53380.0, 41113.79443102765, 59854.70072649609, 61403.385966141555, 61410.0, 61749.69125154345, 11267.323960562393, 11277.71805704864, 11306.773864522827, 11387.829182562435, 11611.361375124448, 10866.728331791452, 11916.702082448008, 12526.812097818722, 12550.309732964775, 13332.333383330988, 11089.27919685218, 11312.717182070513, 11513.597024104116, 11715.0, 12432.689182770504, 11303.0, 11491.770164596828, 11615.88384116148, 11625.59310424131, 12254.592615045363, 11047.668569942914, 11107.333559986426, 11248.156388270749, 11454.484548195185, 11991.280523168638, 8703.84512392261, 8805.603747831236, 9020.684276050306, 9410.670626528039, 9496.810063798823, 8854.0, 8895.421797583136, 9106.499142547224, 9716.659916902874, 9880.35777674449], "unit": "ms", "name": "yui.html", "value": 6931.915624256992}], "name": "dromaeo_css", "value": 7815.594549802529}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 102.0, 110.0, 109.0, 110.0, 99.0, 111.0, 102.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 145.0, 156.0, 119.0, 138.0, 112.0, 151.0, 141.0, 117.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [181.0, 182.0, 186.0, 180.0, 181.0, 207.0, 262.0, 186.0, 184.0, 173.0], "unit": "ms", "name": "audio-dft", "value": 192.2}, {"lowerIsBetter": true, "replicates": [63.0, 69.0, 72.0, 72.0, 56.0, 57.0, 56.0, 68.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 63.9}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 117.0, 75.0, 75.0, 74.0, 115.0, 110.0, 111.0, 146.0], "unit": "ms", "name": "audio-oscillator", "value": 99.1}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 86.0, 85.0, 84.0, 85.0, 89.0, 85.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.3}, {"lowerIsBetter": true, "replicates": [102.0, 143.0, 95.0, 93.0, 91.0, 118.0, 150.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 107.2}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 107.0, 141.0, 144.0, 86.0, 88.0, 85.0, 86.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 99.3}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 62.0, 53.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 106.0, 109.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 128.0, 121.0, 130.0, 120.0, 124.0, 121.0, 124.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [178.0, 170.0, 134.0, 134.0, 136.0, 127.0, 138.0, 134.0, 137.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 66.0, 66.0, 64.0, 66.0, 67.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1426.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.7351430667645], "unit": "score", "name": "Richards", "value": 240.5831299999999}, {"lowerIsBetter": false, "replicates": [160.61676839061997], "unit": "score", "name": "DeltaBlue", "value": 411.6506680000001}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [4686.915887850468], "unit": "score", "name": "Decrypt", "value": 56.79235692921238}, {"lowerIsBetter": false, "replicates": [1712.3287671232877], "unit": "score", "name": "RayTrace", "value": 432.1535759999999}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12469.135802469136], "unit": "score", "name": "Boyer", "value": 53.449012871287174}, {"lowerIsBetter": false, "replicates": [30969.696969696968], "unit": "score", "name": "RegExp", "value": 29.415366927592935}, {"lowerIsBetter": false, "replicates": [646.2628865979382], "unit": "score", "name": "Splay", "value": 126.09574476570286}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 20550.09748687478}]} 12:15:40 INFO - RETURN: dromaeo_css: 7815.60 12:15:40 INFO - RETURN: kraken: 1426.20 12:15:40 INFO - RETURN: v8_7: 20550.10 12:15:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20550.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1426.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7815.60"}}} 12:15:40 INFO - Return code: 0 12:15:40 INFO - # TBPL SUCCESS # 12:15:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:40 INFO - 2015-11-23 12:15:40.653 screenresolution[2160:13038] starting screenresolution argv=screenresolution get 12:15:40 INFO - 2015-11-23 12:15:40.655 screenresolution[2160:13038] Display 0: 1600x1200x32@60 12:15:40 INFO - 2015-11-23 12:15:40.661 screenresolution[2161:13042] starting screenresolution argv=screenresolution list 12:15:40 INFO - Available Modes on Display 0 12:15:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:40 INFO - Intel Iris: 12:15:40 INFO - Chipset Model: Intel Iris 12:15:40 INFO - Type: GPU 12:15:40 INFO - Bus: Built-In 12:15:40 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:40 INFO - Vendor: Intel (0x8086) 12:15:40 INFO - Device ID: 0x0a2e 12:15:40 INFO - Revision ID: 0x0009 12:15:40 INFO - Displays: 12:15:40 INFO - Display: 12:15:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:40 INFO - Display Serial Number: 1600x1200 60 12:15:40 INFO - Main Display: Yes 12:15:40 INFO - Mirror: Off 12:15:40 INFO - Online: Yes 12:15:40 INFO - Rotation: Supported 12:15:40 INFO - Return code: 0 12:15:40 INFO - Running post-action listener: _resource_record_post_action 12:15:40 INFO - Running post-run listener: _resource_record_post_run 12:15:41 INFO - Total resource usage - Wall time: 1240s; CPU: 52.0%; Read bytes: 2514944; Write bytes: 689688064; Read time: 40; Write time: 2284 12:15:41 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335938048; Write bytes: 335927296; Read time: 26167; Write time: 646 12:15:41 INFO - run-tests - Wall time: 1211s; CPU: 52.0%; Read bytes: 2514944; Write bytes: 342550016; Read time: 40; Write time: 1603 12:15:41 INFO - Running post-run listener: _upload_blobber_files 12:15:41 INFO - Blob upload gear active. 12:15:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:15:41 INFO - Copying logs to upload dir... 12:15:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.777494 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 12:15:42.018771) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:42.022011) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009557 build_url: 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:42.044657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:42.044996) ========= 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.SgdSi7uTqf/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.AsbtJKYAI2/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005196 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:42.095486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:15:42.096024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:15:42.096694) ========= ========= Total master_lag: 0.19 =========