builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0061 starttime: 1447581385.95 results: success (0) buildid: 20151115004216 builduid: 8164b41507e14f739f15628f8b000f0a revision: 694f70dd36857b0c504b3feddf7538fb94797654 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:25.945453) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:25.945944) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:25.946299) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.49 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.443375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.443906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.765030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.765356) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.014130 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.858101) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.858481) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.858907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:26.859237) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 01:56:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.9M=0.001s 2015-11-15 01:56:27 (10.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.120374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.120791) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.123809 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.263265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.263909) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 694f70dd36857b0c504b3feddf7538fb94797654 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 694f70dd36857b0c504b3feddf7538fb94797654 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 01:56:27,368 truncating revision to first 12 chars 2015-11-15 01:56:27,369 Setting DEBUG logging. 2015-11-15 01:56:27,369 attempt 1/10 2015-11-15 01:56:27,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/694f70dd3685?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 01:56:27,620 unpacking tar archive at: mozilla-inbound-694f70dd3685/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544170 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.835256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.835590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.864733) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.865053) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 01:56:27.865531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-15 01:56:27.865954) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 01:56:28 INFO - MultiFileLogger online at 20151115 01:56:28 in /builds/slave/test 01:56:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:56:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:56:28 INFO - {'append_to_log': False, 01:56:28 INFO - 'base_work_dir': '/builds/slave/test', 01:56:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:56:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:56:28 INFO - 'branch': 'Mozilla-Inbound', 01:56:28 INFO - 'buildbot_json_path': 'buildprops.json', 01:56:28 INFO - 'config_files': ('talos/mac_config.py',), 01:56:28 INFO - 'default_actions': ('clobber', 01:56:28 INFO - 'read-buildbot-config', 01:56:28 INFO - 'download-and-extract', 01:56:28 INFO - 'populate-webroot', 01:56:28 INFO - 'create-virtualenv', 01:56:28 INFO - 'install', 01:56:28 INFO - 'run-tests'), 01:56:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:56:28 INFO - 'download_minidump_stackwalk': True, 01:56:28 INFO - 'download_symbols': 'ondemand', 01:56:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:56:28 INFO - 'tooltool.py': '/tools/tooltool.py', 01:56:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:56:28 INFO - '/tools/misc-python/virtualenv.py')}, 01:56:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:56:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:56:28 INFO - 'installer_path': 'installer.exe', 01:56:28 INFO - 'log_level': 'info', 01:56:28 INFO - 'log_name': 'talos', 01:56:28 INFO - 'log_to_console': True, 01:56:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:56:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:56:28 INFO - 'opt_config_files': (), 01:56:28 INFO - 'pip_index': False, 01:56:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:56:28 INFO - 'cmd': ('bash', 01:56:28 INFO - '-c', 01:56:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:56:28 INFO - 'enabled': True, 01:56:28 INFO - 'halt_on_failure': False, 01:56:28 INFO - 'name': 'check_screen_resolution'},), 01:56:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:56:28 INFO - 'cmd': ('bash', 01:56:28 INFO - '-c', 01:56:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:56:28 INFO - 'enabled': True, 01:56:28 INFO - 'halt_on_failure': False, 01:56:28 INFO - 'name': 'check_screen_resolution'},), 01:56:28 INFO - 'run_cmd_checks_enabled': True, 01:56:28 INFO - 'sps_profile': False, 01:56:28 INFO - 'sps_profile_interval': 0, 01:56:28 INFO - 'suite': 'dromaeojs', 01:56:28 INFO - 'system_bits': '64', 01:56:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:56:28 INFO - 'title': 't-yosemite-r5-0061', 01:56:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:56:28 INFO - 'use_talos_json': True, 01:56:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:56:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:56:28 INFO - 'work_dir': 'build'} 01:56:28 INFO - ##### 01:56:28 INFO - ##### Running clobber step. 01:56:28 INFO - ##### 01:56:28 INFO - Running pre-action listener: _resource_record_pre_action 01:56:28 INFO - Running main action method: clobber 01:56:28 INFO - rmtree: /builds/slave/test/build 01:56:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:56:32 INFO - Running post-action listener: _resource_record_post_action 01:56:32 INFO - ##### 01:56:32 INFO - ##### Running read-buildbot-config step. 01:56:32 INFO - ##### 01:56:32 INFO - Running pre-action listener: _resource_record_pre_action 01:56:32 INFO - Running main action method: read_buildbot_config 01:56:32 INFO - Using buildbot properties: 01:56:32 INFO - { 01:56:32 INFO - "properties": { 01:56:32 INFO - "buildnumber": 3421, 01:56:32 INFO - "product": "firefox", 01:56:32 INFO - "script_repo_revision": "production", 01:56:32 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 01:56:32 INFO - "repository": "", 01:56:32 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 01:56:32 INFO - "buildid": "20151115004216", 01:56:32 INFO - "slavename": "t-yosemite-r5-0061", 01:56:32 INFO - "pgo_build": "False", 01:56:32 INFO - "basedir": "/builds/slave/test", 01:56:32 INFO - "project": "", 01:56:32 INFO - "platform": "yosemite", 01:56:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:56:32 INFO - "slavebuilddir": "test", 01:56:32 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 01:56:32 INFO - "branch": "mozilla-inbound", 01:56:32 INFO - "repo_path": "integration/mozilla-inbound", 01:56:32 INFO - "stage_platform": "macosx64", 01:56:32 INFO - "builduid": "8164b41507e14f739f15628f8b000f0a", 01:56:32 INFO - "revision": "694f70dd36857b0c504b3feddf7538fb94797654" 01:56:32 INFO - }, 01:56:32 INFO - "sourcestamp": { 01:56:32 INFO - "repository": "", 01:56:32 INFO - "hasPatch": false, 01:56:32 INFO - "project": "", 01:56:32 INFO - "branch": "mozilla-inbound-macosx64-talos", 01:56:32 INFO - "changes": [ 01:56:32 INFO - { 01:56:32 INFO - "category": null, 01:56:32 INFO - "files": [ 01:56:32 INFO - { 01:56:32 INFO - "url": null, 01:56:32 INFO - "name": "https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 01:56:32 INFO - } 01:56:32 INFO - ], 01:56:32 INFO - "repository": "", 01:56:32 INFO - "rev": "694f70dd36857b0c504b3feddf7538fb94797654", 01:56:32 INFO - "who": "philringnalda@gmail.com", 01:56:32 INFO - "when": 1447581351, 01:56:32 INFO - "number": 6663199, 01:56:32 INFO - "comments": "Bug 1215800 - Disable wpt close_beforeunload.html and close_unload.html for very frequent timeouts", 01:56:32 INFO - "project": "", 01:56:32 INFO - "at": "Sun 15 Nov 2015 01:55:51", 01:56:32 INFO - "branch": "mozilla-inbound-macosx64-talos", 01:56:32 INFO - "revlink": "", 01:56:32 INFO - "properties": [ 01:56:32 INFO - [ 01:56:32 INFO - "buildid", 01:56:32 INFO - "20151115004216", 01:56:32 INFO - "Change" 01:56:32 INFO - ], 01:56:32 INFO - [ 01:56:32 INFO - "builduid", 01:56:32 INFO - "8164b41507e14f739f15628f8b000f0a", 01:56:32 INFO - "Change" 01:56:32 INFO - ], 01:56:32 INFO - [ 01:56:32 INFO - "pgo_build", 01:56:32 INFO - "False", 01:56:32 INFO - "Change" 01:56:32 INFO - ] 01:56:32 INFO - ], 01:56:32 INFO - "revision": "694f70dd36857b0c504b3feddf7538fb94797654" 01:56:32 INFO - } 01:56:32 INFO - ], 01:56:32 INFO - "revision": "694f70dd36857b0c504b3feddf7538fb94797654" 01:56:32 INFO - } 01:56:32 INFO - } 01:56:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 01:56:32 INFO - Running post-action listener: _resource_record_post_action 01:56:32 INFO - ##### 01:56:32 INFO - ##### Running download-and-extract step. 01:56:32 INFO - ##### 01:56:32 INFO - Running pre-action listener: _resource_record_pre_action 01:56:32 INFO - Running main action method: download_and_extract 01:56:32 INFO - mkdir: /builds/slave/test/build/tests 01:56: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')]} 01:56:32 INFO - https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/test_packages.json 01:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/test_packages.json 01:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:56:39 INFO - Downloaded 1149 bytes. 01:56:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:56:39 INFO - Using the following test package requirements: 01:56:39 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:56:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 01:56:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'jsshell-mac.zip'], 01:56:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 01:56:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:56:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 01:56:39 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 01:56:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 01:56:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:56:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:56:39 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 01:56:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:56: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')]} 01:56:39 INFO - https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:56:43 INFO - Downloaded 17464010 bytes. 01:56:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 01:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:56:50 INFO - Return code: 0 01:56:50 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 01:56: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')]} 01:56:50 INFO - https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:56:55 INFO - Downloaded 17464010 bytes. 01:56:55 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 01:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:56:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:57:01 INFO - Return code: 0 01:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:01 INFO - https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:57:02 INFO - Downloaded 11131693 bytes. 01:57:02 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 01:57:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:57:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 01:57:02 INFO - Return code: 0 01:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:02 INFO - https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:57:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:57:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:57:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 01:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_jZuMnH5R2yJlQESKDqqOw/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 01:57:06 INFO - Downloaded 108669599 bytes. 01:57:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:57:06 INFO - mkdir: /builds/slave/test/properties 01:57:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:57:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:57:06 INFO - Contents: 01:57:06 INFO - build_url:https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:57:06 INFO - Running post-action listener: _resource_record_post_action 01:57:06 INFO - Running post-action listener: set_extra_try_arguments 01:57:06 INFO - ##### 01:57:06 INFO - ##### Running populate-webroot step. 01:57:06 INFO - ##### 01:57:06 INFO - Running pre-action listener: _resource_record_pre_action 01:57:06 INFO - Running main action method: populate_webroot 01:57:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:57:06 INFO - '../fennec_ids.txt'], 01:57:06 INFO - 'tests': ['tcheck2']}, 01:57:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:06 INFO - '--tppagecycles', 01:57:06 INFO - '7'], 01:57:06 INFO - 'tests': ['tsvgm']}}, 01:57:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:57:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:57:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:57:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'tests': ['damp', 'tps']}, 01:57:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['damp', 'tps']}, 01:57:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:57:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:06 INFO - 'other': {'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'other_l64': {'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'other_nol64': {'tests': ['a11yr', 01:57:06 INFO - 'ts_paint', 01:57:06 INFO - 'tpaint', 01:57:06 INFO - 'sessionrestore', 01:57:06 INFO - 'sessionrestore_no_auto_restore']}, 01:57:06 INFO - 'svgr': {'tests': ['tsvgx', 01:57:06 INFO - 'tsvgr_opacity', 01:57:06 INFO - 'tart', 01:57:06 INFO - 'tscrollx', 01:57:06 INFO - 'cart']}, 01:57:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['tsvgx', 01:57:06 INFO - 'tsvgr_opacity', 01:57:06 INFO - 'tart', 01:57:06 INFO - 'tscrollx', 01:57:06 INFO - 'cart']}, 01:57:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'tests': ['tp5o']}, 01:57:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'talos_options': ['--e10s'], 01:57:06 INFO - 'tests': ['tp5o']}, 01:57:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'talos_options': ['--xperf_path', 01:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:06 INFO - 'tests': ['tp5n']}, 01:57:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:06 INFO - 'talos_options': ['--e10s', 01:57:06 INFO - '--xperf_path', 01:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:06 INFO - 'tests': ['tp5n']}}, 01:57:06 INFO - 'talos.zip': {'path': '', 01:57:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:06 INFO - Running post-action listener: _resource_record_post_action 01:57:06 INFO - ##### 01:57:06 INFO - ##### Running create-virtualenv step. 01:57:06 INFO - ##### 01:57:06 INFO - Running pre-action listener: _resource_record_pre_action 01:57:06 INFO - Running main action method: create_virtualenv 01:57:06 INFO - Creating virtualenv /builds/slave/test/build/venv 01:57:06 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 01:57:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:57:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:06 INFO - Using real prefix '/tools/python27' 01:57:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:57:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:11 INFO - Installing pip.................done. 01:57:11 INFO - Return code: 0 01:57:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:57:11 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')]} 01:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:11 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')]} 01:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:11 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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:11 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 01:57:11 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 01:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:11 INFO - 'HOME': '/Users/cltbld', 01:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:11 INFO - 'LOGNAME': 'cltbld', 01:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:11 INFO - 'MOZ_NO_REMOTE': '1', 01:57:11 INFO - 'NO_EM_RESTART': '1', 01:57:11 INFO - 'PAGER': '/bin/cat', 01:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:11 INFO - 'PWD': '/builds/slave/test', 01:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:11 INFO - 'SHELL': '/bin/bash', 01:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:11 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:11 INFO - 'USER': 'cltbld', 01:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:11 INFO - 'XPC_FLAGS': '0x0', 01:57:11 INFO - 'XPC_SERVICE_NAME': '0', 01:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:12 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 01:57:12 INFO - Cleaning up... 01:57:12 INFO - Return code: 0 01:57:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:12 INFO - 'HOME': '/Users/cltbld', 01:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:12 INFO - 'LOGNAME': 'cltbld', 01:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:12 INFO - 'MOZ_NO_REMOTE': '1', 01:57:12 INFO - 'NO_EM_RESTART': '1', 01:57:12 INFO - 'PAGER': '/bin/cat', 01:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:12 INFO - 'PWD': '/builds/slave/test', 01:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:12 INFO - 'SHELL': '/bin/bash', 01:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:12 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:12 INFO - 'USER': 'cltbld', 01:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:12 INFO - 'XPC_FLAGS': '0x0', 01:57:12 INFO - 'XPC_SERVICE_NAME': '0', 01:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:12 INFO - Downloading/unpacking psutil>=0.7.1 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:15 INFO - Installing collected packages: psutil 01:57:15 INFO - Running setup.py install for psutil 01:57:15 INFO - building 'psutil._psutil_osx' extension 01:57:15 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 01:57:18 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 01:57:18 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 01:57:18 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 01:57:18 INFO - building 'psutil._psutil_posix' extension 01:57:18 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 01:57:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:57:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:57:18 INFO - ^ 01:57:18 INFO - 1 warning generated. 01:57:18 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 01:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:19 INFO - Successfully installed psutil 01:57:19 INFO - Cleaning up... 01:57:19 INFO - Return code: 0 01:57:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:19 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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:19 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 01:57:19 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 01:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:19 INFO - 'HOME': '/Users/cltbld', 01:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:19 INFO - 'LOGNAME': 'cltbld', 01:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:19 INFO - 'MOZ_NO_REMOTE': '1', 01:57:19 INFO - 'NO_EM_RESTART': '1', 01:57:19 INFO - 'PAGER': '/bin/cat', 01:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:19 INFO - 'PWD': '/builds/slave/test', 01:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:19 INFO - 'SHELL': '/bin/bash', 01:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:19 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:19 INFO - 'USER': 'cltbld', 01:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:19 INFO - 'XPC_FLAGS': '0x0', 01:57:19 INFO - 'XPC_SERVICE_NAME': '0', 01:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:57:19 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 01:57:19 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 01:57:19 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 01:57:19 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 01:57:19 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 01:57:19 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 01:57:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:57:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:57:22 INFO - Installing collected packages: mozsystemmonitor 01:57:22 INFO - Running setup.py install for mozsystemmonitor 01:57:22 INFO - Successfully installed mozsystemmonitor 01:57:22 INFO - Cleaning up... 01:57:22 INFO - Return code: 0 01:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:22 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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:22 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 01:57:22 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 01:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:22 INFO - 'HOME': '/Users/cltbld', 01:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:22 INFO - 'LOGNAME': 'cltbld', 01:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:22 INFO - 'MOZ_NO_REMOTE': '1', 01:57:22 INFO - 'NO_EM_RESTART': '1', 01:57:22 INFO - 'PAGER': '/bin/cat', 01:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:22 INFO - 'PWD': '/builds/slave/test', 01:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:22 INFO - 'SHELL': '/bin/bash', 01:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:22 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:22 INFO - 'USER': 'cltbld', 01:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:22 INFO - 'XPC_FLAGS': '0x0', 01:57:22 INFO - 'XPC_SERVICE_NAME': '0', 01:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:23 INFO - Downloading/unpacking blobuploader==1.2.4 01:57:23 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 01:57:23 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 01:57:23 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 01:57:23 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 01:57:23 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 01:57:23 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 01:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 01:57:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:57:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:57:25 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 01:57:25 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 01:57:25 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 01:57:25 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 01:57:25 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 01:57:25 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 01:57:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:57:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:27 INFO - Downloading docopt-0.6.1.tar.gz 01:57:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:57:27 INFO - Installing collected packages: blobuploader, requests, docopt 01:57:27 INFO - Running setup.py install for blobuploader 01:57:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:57:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:57:27 INFO - Running setup.py install for requests 01:57:28 INFO - Running setup.py install for docopt 01:57:28 INFO - Successfully installed blobuploader requests docopt 01:57:28 INFO - Cleaning up... 01:57:28 INFO - Return code: 0 01:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:28 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')]} 01:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:28 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')]} 01:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:28 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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:28 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 01:57:28 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 01:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:28 INFO - 'HOME': '/Users/cltbld', 01:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:28 INFO - 'LOGNAME': 'cltbld', 01:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:28 INFO - 'MOZ_NO_REMOTE': '1', 01:57:28 INFO - 'NO_EM_RESTART': '1', 01:57:28 INFO - 'PAGER': '/bin/cat', 01:57:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:28 INFO - 'PWD': '/builds/slave/test', 01:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:28 INFO - 'SHELL': '/bin/bash', 01:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:28 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:28 INFO - 'USER': 'cltbld', 01:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:28 INFO - 'XPC_FLAGS': '0x0', 01:57:28 INFO - 'XPC_SERVICE_NAME': '0', 01:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:28 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-ync0PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:28 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-297X7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:28 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-s2qbII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-gMoUa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-0AGBC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-3tQkjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-x2Cs96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-gDtxy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-J8ZXEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:29 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-A7uDKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-JaDDOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-M_Poep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-FjnQcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-BqTw74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-04EZNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-7UNoMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:30 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-zDhxIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:57:31 INFO - Running setup.py install for manifestparser 01:57:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:57:31 INFO - Running setup.py install for mozcrash 01:57:31 INFO - Running setup.py install for mozdebug 01:57:31 INFO - Running setup.py install for mozdevice 01:57:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:57:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:57:31 INFO - Running setup.py install for mozfile 01:57:32 INFO - Running setup.py install for mozhttpd 01:57:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Running setup.py install for mozinfo 01:57:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Running setup.py install for mozInstall 01:57:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:57:32 INFO - Running setup.py install for mozleak 01:57:32 INFO - Running setup.py install for mozlog 01:57:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Running setup.py install for moznetwork 01:57:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Running setup.py install for mozprocess 01:57:33 INFO - Running setup.py install for mozprofile 01:57:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Running setup.py install for mozrunner 01:57:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:57:33 INFO - Running setup.py install for mozscreenshot 01:57:34 INFO - Running setup.py install for moztest 01:57:34 INFO - Running setup.py install for mozversion 01:57:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:57:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:57:34 INFO - Cleaning up... 01:57:34 INFO - Return code: 0 01:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:34 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 01:57:34 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 01:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:34 INFO - 'HOME': '/Users/cltbld', 01:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:34 INFO - 'LOGNAME': 'cltbld', 01:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:34 INFO - 'MOZ_NO_REMOTE': '1', 01:57:34 INFO - 'NO_EM_RESTART': '1', 01:57:34 INFO - 'PAGER': '/bin/cat', 01:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:34 INFO - 'PWD': '/builds/slave/test', 01:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:34 INFO - 'SHELL': '/bin/bash', 01:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:34 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:34 INFO - 'USER': 'cltbld', 01:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:34 INFO - 'XPC_FLAGS': '0x0', 01:57:34 INFO - 'XPC_SERVICE_NAME': '0', 01:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:34 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-t41INZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:34 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)) 01:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:34 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-JdA_Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-dNfEsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-shF3kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-tNinaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-boOGnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-YMV0_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-kAzjHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:35 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)) 01:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:35 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-WgKFFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-IX4ROC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-8So0EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-oKu7wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-ct_cNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-4ch_bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-B2nboq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:36 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)) 01:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:36 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-D3Z2Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:37 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)) 01:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:37 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-yYpf1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:37 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)) 01:57:37 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)) 01:57:37 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)) 01:57:37 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)) 01:57:37 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)) 01:57:37 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)) 01:57:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:39 INFO - Downloading blessings-1.5.1.tar.gz 01:57:39 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 01:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:57:40 INFO - Installing collected packages: blessings 01:57:40 INFO - Running setup.py install for blessings 01:57:40 INFO - Successfully installed blessings 01:57:40 INFO - Cleaning up... 01:57:40 INFO - Return code: 0 01:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:40 INFO - Reading from file tmpfile_stdout 01:57:40 INFO - Current package versions: 01:57:40 INFO - blessings == 1.5.1 01:57:40 INFO - blobuploader == 1.2.4 01:57:40 INFO - docopt == 0.6.1 01:57:40 INFO - manifestparser == 1.1 01:57:40 INFO - mozInstall == 1.12 01:57:40 INFO - mozcrash == 0.16 01:57:40 INFO - mozdebug == 0.1 01:57:40 INFO - mozdevice == 0.47 01:57:40 INFO - mozfile == 1.2 01:57:40 INFO - mozhttpd == 0.7 01:57:40 INFO - mozinfo == 0.9 01:57:40 INFO - mozleak == 0.1 01:57:40 INFO - mozlog == 3.0 01:57:40 INFO - moznetwork == 0.27 01:57:40 INFO - mozprocess == 0.22 01:57:40 INFO - mozprofile == 0.27 01:57:40 INFO - mozrunner == 6.11 01:57:40 INFO - mozscreenshot == 0.1 01:57:40 INFO - mozsystemmonitor == 0.0 01:57:40 INFO - moztest == 0.7 01:57:40 INFO - mozversion == 1.4 01:57:40 INFO - psutil == 3.1.1 01:57:40 INFO - requests == 1.2.3 01:57:40 INFO - wsgiref == 0.1.2 01:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:40 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 0x103dd7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103db4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb87019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/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.DsnWamZhex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:57:40 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 01:57:40 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 01:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:40 INFO - 'HOME': '/Users/cltbld', 01:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:40 INFO - 'LOGNAME': 'cltbld', 01:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:40 INFO - 'MOZ_NO_REMOTE': '1', 01:57:40 INFO - 'NO_EM_RESTART': '1', 01:57:40 INFO - 'PAGER': '/bin/cat', 01:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:40 INFO - 'PWD': '/builds/slave/test', 01:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:40 INFO - 'SHELL': '/bin/bash', 01:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:57:40 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:40 INFO - 'USER': 'cltbld', 01:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:40 INFO - 'XPC_FLAGS': '0x0', 01:57:40 INFO - 'XPC_SERVICE_NAME': '0', 01:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 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)) 01:57:41 INFO - Cleaning up... 01:57:41 INFO - Return code: 0 01:57:41 INFO - Running post-action listener: _resource_record_post_action 01:57:41 INFO - Running post-action listener: _start_resource_monitoring 01:57:41 INFO - Starting resource monitoring. 01:57:41 INFO - ##### 01:57:41 INFO - ##### Running install step. 01:57:41 INFO - ##### 01:57:41 INFO - Running pre-action listener: _resource_record_pre_action 01:57:41 INFO - Running main action method: install 01:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:41 INFO - Reading from file tmpfile_stdout 01:57:41 INFO - Detecting whether we're running mozinstall >=1.0... 01:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:57:41 INFO - Reading from file tmpfile_stdout 01:57:41 INFO - Output received: 01:57:41 INFO - Usage: mozinstall [options] installer 01:57:41 INFO - Options: 01:57:41 INFO - -h, --help show this help message and exit 01:57:41 INFO - -d DEST, --destination=DEST 01:57:41 INFO - Directory to install application into. [default: 01:57:41 INFO - "/builds/slave/test"] 01:57:41 INFO - --app=APP Application being installed. [default: firefox] 01:57:41 INFO - mkdir: /builds/slave/test/build/application 01:57:41 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'] 01:57:41 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 01:58:24 INFO - Reading from file tmpfile_stdout 01:58:24 INFO - Output received: 01:58:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:58:24 INFO - Running post-action listener: _resource_record_post_action 01:58:24 INFO - ##### 01:58:24 INFO - ##### Running run-tests step. 01:58:24 INFO - ##### 01:58:24 INFO - Running pre-action listener: _resource_record_pre_action 01:58:24 INFO - Running main action method: run_tests 01:58:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:58:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:58:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:58:24 INFO - 2015-11-15 01:58:24.697 screenresolution[1637:8436] starting screenresolution argv=screenresolution get 01:58:24 INFO - 2015-11-15 01:58:24.701 screenresolution[1637:8436] Display 0: 1600x1200x32@60 01:58:24 INFO - 2015-11-15 01:58:24.708 screenresolution[1638:8438] starting screenresolution argv=screenresolution list 01:58:24 INFO - Available Modes on Display 0 01:58:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:58:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:58:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:58:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:58:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:58:24 INFO - Intel HD Graphics 3000: 01:58:24 INFO - Chipset Model: Intel HD Graphics 3000 01:58:24 INFO - Type: GPU 01:58:24 INFO - Bus: Built-In 01:58:24 INFO - VRAM (Total): 512 MB 01:58:24 INFO - VRAM (Dynamic, Max): 10 01:58:24 INFO - Vendor: Intel (0x8086) 01:58:24 INFO - Device ID: 0x0116 01:58:24 INFO - Revision ID: 0x0009 01:58:24 INFO - Displays: 01:58:24 INFO - Display: 01:58:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:58:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:58:24 INFO - Display Serial Number: 1600x1200 60 01:58:24 INFO - Main Display: Yes 01:58:24 INFO - Mirror: Off 01:58:24 INFO - Online: Yes 01:58:24 INFO - Rotation: Supported 01:58:24 INFO - Return code: 0 01:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:58:25 INFO - Python 2.7.3 01:58:25 INFO - Return code: 0 01:58:25 INFO - grabbing minidump binary from tooltool 01:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:25 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 0x103cfa9f0>, '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 0x103a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cee8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:58:25 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 01:58:25 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 01:58:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:25 INFO - Return code: 0 01:58:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:58:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] in /builds/slave/test/build 01:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0061 --webServer localhost 01:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CByXrlXxFt/Render', 01:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:25 INFO - 'HOME': '/Users/cltbld', 01:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:25 INFO - 'LOGNAME': 'cltbld', 01:58:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:58:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:25 INFO - 'MOZ_NO_REMOTE': '1', 01:58:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:58:25 INFO - 'NO_EM_RESTART': '1', 01:58:25 INFO - 'PAGER': '/bin/cat', 01:58:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:25 INFO - 'PWD': '/builds/slave/test', 01:58:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:25 INFO - 'SHELL': '/bin/bash', 01:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DsnWamZhex/Listeners', 01:58:25 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 01:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:25 INFO - 'USER': 'cltbld', 01:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:25 INFO - 'XPC_FLAGS': '0x0', 01:58:25 INFO - 'XPC_SERVICE_NAME': '0', 01:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:58:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] with output_timeout 3600 01:58:25 INFO - mozversion INFO | application_buildid: 20151115004216 01:58:25 INFO - mozversion INFO | application_changeset: 694f70dd36857b0c504b3feddf7538fb94797654 01:58:25 INFO - mozversion INFO | application_display_name: Nightly 01:58:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:25 INFO - mozversion INFO | application_name: Firefox 01:58:25 INFO - mozversion INFO | application_remotingname: firefox 01:58:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:58:25 INFO - mozversion INFO | application_vendor: Mozilla 01:58:25 INFO - mozversion INFO | application_version: 45.0a1 01:58:25 INFO - mozversion INFO | platform_buildid: 20151115004216 01:58:25 INFO - mozversion INFO | platform_changeset: 694f70dd36857b0c504b3feddf7538fb94797654 01:58:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:58:25 INFO - mozversion INFO | platform_version: 45.0a1 01:58:25 INFO - 2015-11-15 01:58:25,521 DEBUG : using testdate: 1447581505 01:58:25 INFO - 2015-11-15 01:58:25,521 DEBUG : actual date: 1447581505 01:58:25 INFO - 2015-11-15 01:58:25,533 INFO : starting webserver on 'localhost:49266' 01:58:25 INFO - 2015-11-15 01:58:25,534 INFO : Starting test suite t-yosemite-r5-0061 01:58:25 INFO - 2015-11-15 01:58:25,534 INFO : Starting test dromaeo_css 01:58:25 INFO - 2015-11-15 01:58:25,534 DEBUG : operating with platform_type : mac_ 01:58:25 INFO - 2015-11-15 01:58:25,535 INFO : Initialising browser for dromaeo_css test... 01:58:25 INFO - 2015-11-15 01:58:25,563 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpdVJBnl/profile http://localhost:49266/getInfo.html 01:58:29 INFO - 2015-11-15 01:58:29,294 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:58:29 INFO - 2015-11-15 01:58:29,294 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:58:29 INFO - 2015-11-15 01:58:29,295 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:58:29 INFO - 2015-11-15 01:58:29,295 DEBUG : BROWSER_OUTPUT: __metrics 01:58:29 INFO - 2015-11-15 01:58:29,310 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:58:30 INFO - 2015-11-15 01:58:30,093 INFO : Browser initialized. 01:58:30 INFO - 2015-11-15 01:58:30,094 INFO : Running cycle 1/1 for dromaeo_css test... 01:58:30 INFO - 2015-11-15 01:58:30,094 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpdVJBnl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:58:42 INFO - 2015-11-15 01:58:42,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 229974016 01:58:42 INFO - 2015-11-15 01:58:42,335 DEBUG : BROWSER_OUTPUT: 01:59:34 INFO - 2015-11-15 01:59:34,303 DEBUG : BROWSER_OUTPUT: 1447581574299 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] 02:01:44 INFO - 2015-11-15 02:01:44,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 02:01:45 INFO - 2015-11-15 02:01:45,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 326356992 02:01:45 INFO - 2015-11-15 02:01:45,871 DEBUG : BROWSER_OUTPUT: 02:04:48 INFO - 2015-11-15 02:04:48,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 02:04:49 INFO - 2015-11-15 02:04:49,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 361304064 02:04:49 INFO - 2015-11-15 02:04:49,299 DEBUG : BROWSER_OUTPUT: 02:07:51 INFO - 2015-11-15 02:07:51,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 02:07:52 INFO - 2015-11-15 02:07:52,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 324022272 02:07:52 INFO - 2015-11-15 02:07:52,172 DEBUG : BROWSER_OUTPUT: 02:10:54 INFO - 2015-11-15 02:10:54,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 02:10:54 INFO - 2015-11-15 02:10:54,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 316813312 02:10:54 INFO - 2015-11-15 02:10:54,943 DEBUG : BROWSER_OUTPUT: 02:13:58 INFO - 2015-11-15 02:13:58,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 02:13:58 INFO - 2015-11-15 02:13:58,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 320131072 02:13:58 INFO - 2015-11-15 02:13:58,882 DEBUG : BROWSER_OUTPUT: 02:17:01 INFO - 2015-11-15 02:17:01,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 373608448 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2547.299492639524;2645.2725500487363;2665.933351666208;2675.3712877473804;2681.7318268173185;4306.61240488356;4393.780310984446;4461.553844615537;4493;4505.729656220625;4375.846845360421;4395.560443955603;4423.66822488313;4452.421185245914;4542.954570454294;3893.9820717807534;4054.858079967202;4133.318002529579;4159.771212583307;4166.979165104185;4142.71001029928;4175.54069052404;4203.558626344236;4218.472690913636;4256.318988961767;3963.960360396388;3967.4247234150885;4052.4124002019835;4077.245709543744;4105.281575724266;4080.738694342822;4125.1749650070105;4152.584741525853;4155.854545090907;4159.022629682053;4057.797110144481;4068.4304197412384;4084.36692312692;4126.319157339036;4151.356539736345;4254.127903779718;4319.222539942809;4388.319810429389;4413.470383553994;4538.9546104539195;4682.204025315705;4684.625229981593;4707.246840505537;4755;4800.375951126366;4625.074985002979;4771.713697178146;4827.25177597473;4836.056968891067;4861.2041378283775;4273.273543497613;4274.337477690963;4275.187714334266;4397.2964325707735;4445.866624001285;4795.568398844121;4825.517448255217;4837.153498137882;4873.244647079709;4989.426215985208;4585.816567337336;4591.494935557086;4637.814487420465;4644.7213167210075;4667.323238130452;4634.536546345338;4657.720536767804;4718.834840780556;4740.099381117577;4744.881377965578;4649.697769644962;4674.719516829001;4679.251319788817;4737.194676904935;4795.904081918342;4677.6257899367965;4703.035877645075;4746.050789842046;4750;4789.090072886141;3552.751307408457;3584.98207508966;3587.6412358763914;3648.52569166012;3654.3056819204267;3229.273413481948;3334.6665333466945;3358.143673363277;3368.494725791151;3420.4698271767916;4425.380446737459;4444.888877778017;4481.126180394857;4502.234620114523;4561.794719237576;4749.95250047502;4753.263244197155;4827.517248275215;4829.710217386898;4885.853424397274;4366.607005369532;4408.493023302297;4442.755648439367;4455.4876189238;4488.4165058542185;4119.526254480713;4152.709310348247;4191.937120943188;4207.579242075829;4209.6000879916355;4868.78090485929;4921.581665558468;4926.531979461945;4936.234883592905;5014.2979982802435;4645.698029628198;4690.343351930801;4718.834840780693;4731.29030645406;4903.362562866804;4844.270031295074;4906.362172917497;4926.039422312615;4939.703617782944;4960.082384758831;4666.859994200179;4744.003759210605;4751.50109238525;4771.475137734916;4811.230203167476;4695.882602934954;4712.246040633482;4776.59398951093;4784.449788274393;4868.683535570177;4568.200564901195;4683.929741053955;4692.50728673498;4758.952410475851;4785.258284965836;4682.22743247374;4725.456572494069;4749.430068391677;4763.476017637988;4813.855584332476;4440.6447484201835;4476.753778542081;4525.162844873709;4556.202664533627;4708.576228139484;4703.129920964632;4731.219348807408;4753.049390122059;4794.089123066607;4859.392575928009;4614.238650622609;4634.281686338623;4670.182718024264;4682.531746825291;4731.69243999139 02:17:01 INFO - 2015-11-15 02:17:01,993 DEBUG : BROWSER_OUTPUT: |1;ext.html;453.86837817033063;472.7754316699568;474.75075585317705;475.43185892858025;490.87728067983005;26109.347266318353;27038.053668121596;27142.728572714266;27260;32487.837560812222;35329.29341413177;35852;36025;36108.45837312443;36164;7500.174980752126;7549.811254718648;7556.055493063367;7616.3906887448875;7650.158482566913;6869.690863911136;6873.965630171842;6980.476464265175;7324.707011719524;9033;9029.097090290985;9044.954775226148;9075.95462022689;9156.22172115371;9188.724338269829;8327.167283271685;9006.684766033222;9025.052369501174;9117.908820911773;9125.178733913946;6670.366315200048;6782.626955517445;6848.246692863781;8880.777980550538;9047.230985366252;32648;32649;32722.345553089042;33051.3389732204;33098.17254568631;2569.216389001354;2836.546152615572;2837.163036904118;2899.057806212968;2919.5620656901424;22697.205597803997;22856.31431057071;23068.653970190462;23074.65388019181;23358.64962025571;1984.7717512486104;2015.54650203703;2016.9495762605904;2050.0672194151625;2064.112431654388;231188;232521.60958270586;233539;235233;238354;48883.75558122258;49284.50715492871;49659.50340496621;49768.50231497711;49816.75091624591;48265;50841.49158508368;50899.491005089476;53257;54578.45421545813;11994.460249288803;12056.51773929033;12068;12085.879141208476;12131.454084566216;9011.234045106108;9084.636614535344;9114.36199466031;9114.772130696785;9177.449353038839;15801.36794528206;15926.97387496372;16094.678106437806;16322.102284374474;16636.58408539772;7021.297870212938;7288.96355518219;7339.926600734031;7352.338289553966;7411.592362420119;730.9269073092754;753.5591678867814;788.1802924958095;910.8360495110944;913.8081002989446;21469;21768.89115554412;21892.014859331368;22027.779722202893;22141.557168856856;813.9918600813916;814.7515007922522;823.2343920154194;835.8913341265718;865.4244927123392;11353.772924541463;11484.138689598314;11500;11614.245074070328;11663.941680291713;202537;205555;205726;205771.56713246566;209505;41042.38436423456;41077.38383924244;41136.79431602823;41191.7940410296;41206.793966029974;1114.8717897441736;1124.7637996020765;1131.909447244235;1143.085531574737;1143.4454289669504;21866.125354985623;22116.55766884621;22439.43901402478;22461.66307505356;22614.886925565268;38223.80888095542;38711;38962.80518597389;38976.41535377028;39052.6094739049;239133;241340;243670;245041;246426;22370.105195791984;22937.311880643607;24925.750742492342;25283.494330113663;26012.869935650957;34208.14479638029;34264.31471370509;34542.82728586341;34680.65319346875;34920.82539587286;27851.303717407227;28458;29311.85344073266;29425.70574294315;29606.851965740032;21149.89425052865;26961.46077078408;28151.43697126087;28865.7113428863;29126.41747165087;27354.179374618794;27987.440251194454;28005;28144.71855281421;28241.15276541707;23573.69591841822;24726.50546989086;24778.876105619358;25147.371315717253;25452.363690907136;18601.53496162607;18987.140342327446;19735.703964440258;19930.90034549818;20161.596768064264 02:17:01 INFO - 2015-11-15 02:17:01,995 DEBUG : BROWSER_OUTPUT: |2;jquery.html;279.72586864872414;280.78239364492526;281.77598808946885;282.40553634599166;286.78634417359063;14346.139231646108;14743.48397806077;14745.852541474582;14789.260536973148;15618.76571851423;10746.838797418026;10787.352758834475;12688.555900543459;14924.104553726784;14992.850071499282;4300.35494675798;4443.800028998687;4445.888852778674;4474.418325617665;4482.350059241425;4145.481814773153;4146.046409325857;4162.625363717265;4175.832966681344;4208.242516347056;3187.7449804015737;3288.457404528262;3342.3649506593792;4718.150732868083;4943.604511639061;4875.926861097087;4913.803447862081;4926.0394223126505;4937.80248790048;4943.159662857305;4135.462389889325;4201;4208.3687446882905;4213.536510983789;4220.261454245526;15352.846471535253;15424.305906234247;15682;17186.398476053404;17409.390671326444;1606.9678606427924;1708.92309846056;1712.7859017622798;1749.7287920372362;1824.8175182481777;7625.694972201105;7814.882776758353;7945.88081178777;7999.200079992012;11226.101911847032;1285.9292738899358;1305.484333688188;1313.8620444853248;1335.132164093347;1352.134633834347;46442;47746.76126619414;48291.275630865566;48762;48872.18045112765;5264.947350526446;5293.285406470077;5362.195670649356;5379.085555455504;5387.46125387466;6041.395860414012;6111.083337499322;6133.662648554283;6145.139680444741;6169.074638804215;4182.560831112689;4325.2214601371425;4365.06151177492;4366.19225443294;4368.847090351886;4572.108438854391;4574.885627859264;4580.702254353457;4595.149897268949;4597.793099310539;2366.290112966103;2450.47314827313;2458.9672337618244;2480.1071614218868;2485.8632775197175;848.253536887535;850.3282406898604;854.6538651846013;855.6064210463132;912.0469109780296;305.9541068839692;351.206273821166;376.4597802153918;376.91121261264226;384.9230153969161;9328.673496427593;9704.70885873425;9844.310898237054;9911.851322230172;9994.850077248848;354.4134457472887;357.8604344305723;369.62852333405294;372.7428074628498;382.4110869261306;5068.518490743373;5074.3657042869645;5079.415867175248;5167.199084141889;5188.429272779991;308421;309315;313854;478557;482199;58126;58547;58725.11912321319;59376.40623593709;60616.09075863865;414.80089557012803;418.14489369239976;418.8052555561678;419.7628339987897;419.8005947175067;8882.689105881263;8926.062763410007;8941.876306872267;8993.235574976201;9054.81890362176;27399;27600.447991039666;27936.72063279341;28528;28872.422551548432;39715;39995.400068999574;40240;40260.79869600751;40905.18189636131;4930;4972.9254061188385;5119.078565858033;5138.820141295037;5143.794248230029;9384;9484.288678349014;9693.176080033276;9713.854292185482;9780.510974451106;7038.331358520933;7339.412846972336;7406.851862962602;8466.449680770731;8640.611172497127;7079;8072.394570407126;8171.79570510742;8343.624536895975;8432.283255923316;8099.595020249082;8354.874676879974;8529.872051919103;8546.743597692079;8584.613692383733;4998.275250088789;5009.949900501094;5012.899742005213;5013.674111182761;5088.542031217208;7806.102298235775;8317.83364332722;8329.916700832913;8514.659413623633;8642.135786421308 02:17:01 INFO - 2015-11-15 02:17:01,998 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1178.611058350744;1199.9820002699962;1279;1332.5735764555343;1514.856088671576;5844.181814545962;6005.12925625784;6090;6094.51243900488;6389.0416437534395;6173.567850250484;6225.470834979021;6225.564210505267;6225.813225603228;6297.118403423525;1854.4714756294459;1854.7310639957198;1860.6185731924922;1886.518937670892;1887.1790771014653;1882.491727233646;1886.1795119123158;1900.8479321654304;1922.2695375757194;1951.804819518051;1867.8972656503886;1878.2111513164505;1899.154876080145;1900.7624046994126;1908.5610309628794;1809.4481183239106;1844.8800827946209;1847.861410394226;1855.1373611270756;1858.1266804601817;1831.2949514436905;1854.2026928420773;1881.4543782303115;1882;1894.4032629721733;5847.26909136358;6165.815025549241;6175.66033868137;6263.6241825490615;6292.087647291163;3754.1928485375774;3842.289176502356;3955.7626542407547;3988.3219852624834;4013.7190396671954;2389.330987323552;2404.483036147237;2429.4290841652196;2468.7654672806057;2473.9628905566433;772.5287574579502;780.8282177920848;785.9449838511307;829.357248132696;838.9203025712548;8869.645214191425;8884.244839188677;8908.420952638058;8943.910560894374;8991.59537820793;3697.2790305890094;3824.349860523718;3834.405667121601;3846.1346197105427;3881.7865017424315;7728.343090837229;7779.45543811939;7788;7807.219278072261;7854.214578542214;4252.362145678111;4257.787110644517;4271.594198551133;4276.743395396286;4298.677599180074;3840.846366145379;3854.402567602026;3874.6319099686048;3885.2812229737588;3889.533256009297;2959.4081183763333;2986.865591048408;2992.8353940533043;2999.9550006749914;3017.0797906638686;980.3088822380205;981.2836629260537;981.8232718110665;983.7934033852828;994.5872462927804;1062.8352605346183;1071.6624263357019;1096.9396683182342;1098.5825386353135;1108.4014632098576;6186.041163619646;6211.3167551569295;6215.34738852423;6224.346443623445;6293.181886354836;394.87364043506375;399.4427773256291;400.56938790800007;405.71599880084057;406.595437539644;4456.598906098467;4456.888577785517;4473.150101480708;4523.32150177476;4542.136993971135;7329.377002954702;7391.519551229153;7664;7862.095858976177;8143.877841832377;7826.178251283647;7828.060632724109;7850.56821874791;7913.248241417056;7929.762107136795;6078.1186727924205;6082.787102451393;6170;6313.494920406449;6331.68341582919;5951.851203719942;5992.580519363777;6011.789587364421;6025.21672182631;6029.397060293935;6837.811900191891;6877.071595334566;6978.127734033246;6996.090508233897;7032.472564557781;7010.369066784014;7295.306945840137;7320.865265883796;7329.963350183215;7372.262773722585;5771.653700777799;5809.738561764815;5814.563907707024;5848.2689663792025;5859.296884373903;5986.700664966647;6192.133101365903;6320.273168585672;6406.583572067801;6413.583117097373;5923.881522369615;5987.43119403656;6045.183900173421;6132.202813634199;6195.2255968004;5872.706364681834;5964.343922168471;5983.192269043623;6026.969865150646;6080.574359794772;6007.339192688713;6048.183495228088;6065.363136870565;6067.605605635619;6113.113598528277;5507.614466987273;5509.3664228612615;5511.751971161388;5558.082916318924;5572.777088916398;5568.888622227451;5592.916106258328;5610.410906854885;5641.12562552805;5642.576806739429 02:17:02 INFO - 2015-11-15 02:17:02,000 DEBUG : BROWSER_OUTPUT: |4;prototype.html;257.8517352522299;259.25464290165775;263.03728354223546;265.4491929246813;265.9428222932069;5014.548690617844;5162.716050617215;5185.481451854813;5193.195054766513;5235.057689615873;5022.698638081709;5138.2806407103035;5139;5230.8692282692955;5252.343457067866;3789.431585262219;3837.2325534892993;3872.8063596820048;3945.9013524661827;3947.703922205839;3819.236152769457;3955.4462375267485;3958.584348643394;3975.642192202701;4004.339284018148;3911.550171730259;3920.0787814863484;3920.745151565139;3953.3872249801184;3965.266425711253;3904.4338570907344;3963.2073585282915;3968.444417781513;3976.8210430530694;3981.163955569348;3377.4089534331392;3396.8641254349795;3420.538227339302;3423.8972830815114;3439.518467414564;4902.313676085351;5008.749562521859;5066.417362003343;5076.6192535559985;5118.027574760821;4398.846040388603;4414.889627759299;4442.044960333512;4459.710118842265;4489.685721999462;5349.465053494659;5421.972890135524;5430.484104010113;5444.863878403032;5459.344878614552;3487.075924879909;3581.3374525712825;3600.0999750062483;3703.5000274962804;3717.4609681596016;5589.944100559023;5698.629589076738;5754.251947246873;5785.334686511021;5786.623869448515;3734.439834024918;3742.8502859885843;3757.492738480325;3789.204267103884;3793.696504279651;3790.1282704977457;3803.714721395851;3816.2939856126704;3875.922481550353;3881.7476864003747;4182.519010313792;4407.4050003249795;4482.596566309048;4487.685861989629;4495.011097558598;5416.702081385482;5473.0969390050195;5485.725713714299;5512.062949298629;5525.640833345819;1296.6887946892866;1299.6231092983119;1315.6973896003972;1316.2957817567556;1316.8551459339465;826.2150956591263;840.2102024097329;851.7998270406449;855.341387131905;864.1747131489412;5256.658317209369;5285.68285902847;5292.655977361459;5301.469853014668;5322.281491998608;5686.2607860977805;5707.286589176353;5713.885722285614;5732.7706891723865;5733.168690539848;5269.446708095595;5284.260203571503;5294.97352513235;5296.761645725875;5299.814506492255;2996.4361094772134;3048.085574327693;3078.599782028322;3092.304231547884;3107.90676279712;5879.412058794086;5879.441453061952;5886.352501224862;5929.199558059693;5965.940340596625;5849.6782676952325;5870.0607902735355;5882.205902203234;5887.528997680175;5894.292684877756;5860.413958604106;5861.267341582302;5874.559408044413;5876.059830427112;5905.43898329658;5618.185363122243;5760;5768.336641286306;5781;5801.332846722681;5427.05026620332;5624.775008999594;5643.26637537134;5672.971635141798;5688.260526131577;5739.512141467855;5757.107648314351;5818;5933.821985340447;5971.313298970674;3660.890173294805;3662.414013757786;3697.4084146537502;3722.050877026341;3728.2357116791536;5574.944250557604;5673;5749.741261643152;5755.050416681368;5765.91351129725;5333.066713325075;5407.0537655909275;5514.476124768141;5514.61397702157;5550.27846379968;5540.335159780852;5564.415736347625;5566.443355664401;5591.832245032656;5601.915971260353;5359.517643412111;5365.061114304903;5387.299651045339;5451.509364157245;5471.699056551769;5439.401665816677;5464.672119672832;5471.015217260931;5531.115021596525;5597.440255974533;5360;5383.7308134593895;5425.782968681208;5437.3747019091725;5447.727613619382 02:17:02 INFO - 2015-11-15 02:17:02,001 DEBUG : BROWSER_OUTPUT: |5;yui.html;559.3036669346664;588.0238803586049;605.1104875832525;617.0774691835705;628.3841835001699;11075.556977720891;11302;11323.433828308573;11463;11476.139289553275;9182.586783594737;9378.718638440841;9396.38923469974;9409.153176214139;9519;691.0981169573704;709.8615769924867;710.0059916117425;721.0122132678238;721.6968873073296;737.8118579762153;739.7521830186894;746.7423738810129;751.9548827070366;762.6529928882345;771.8301973565807;777.8794286885542;783.2519943454016;788.1369899959535;790.119017295714;767.8848172774073;770.0143815915637;777.3975169243824;780.321120625057;786.1313248860013;564.2129229724552;564.2608183279875;566.2695123290949;569.8746275819354;574.6264927796924;11024.393658348788;11220.831687524693;11281.830772538418;11323.377214253213;11323.377214253213;9358.672446464408;9500;9716.708498745049;10033.698989030341;10219.642312519027;6941.132358455193;7199.136103667541;7289.2346303638415;7391.445641576904;7394.408447324255;2697.4335389568214;2707.120185939558;2771.9445611087867;2785.9442811143867;2828.6747024092083;34126.82936585326;34695.653043469494;35071.6492835071;39251;39534.99999999971;7251.3836323912;7309.89035164473;7496.58768767723;7553.282438168365;7721.92278077212;15180.620484487976;15281.847181528265;15311.540653780181;15314.463993760164;15335.61660958485;5557.221988921554;5604.6917419541505;5691.26013618227;5877.059670452707;5967.1347654589845;3031.4998025326017;3123.32848437587;3129.530570414456;3178.3166619176986;3311.172206948263;2446.8287219894437;2465.815063870217;2490.638857365672;2493.8379005364595;2494.663220465214;355.1334743226519;358.36390407027216;359.44286356147865;362.0640643935456;369.88718440875255;368.1899820395141;409.18776229185045;439.45946485822617;457.1884904294837;520.4145336496441;6344.397282258178;6605.86788264232;6701.927726459188;6761.684451409118;6811.591304521745;453.45358842594595;464.2386486162696;482.5512273585529;488.94866039066096;504.19329073482135;3094.05631282461;3097.7057179567905;3150.291184483473;3183.4428974929297;3185.7132858042887;44342.77828610836;44416.55583444124;49096.26355604669;49517.257241141415;49574.50425495699;40933;40987.7950610251;41117.588824111976;41201.58798412037;41298;30728.231794205323;35743;36693.44959825605;37043.629563704555;37252;6308.71610777507;6399.488040956805;6453.838654033687;6629.303923088007;6865.313468653095;28613.570796437652;29230.561541577317;29377.559336610397;29394.265143371587;29430.558541622322;34571.48142777911;37769.62230377661;38414.23171536609;38460.42309365418;38569.6143038566;5265.420803711665;5897.3807750185615;5960.850978725566;6046.486048685911;6107.908381374372;8712.607932642919;8957.552122393723;9233.261339092722;9361.531923403667;9428;7855.646495907584;8189.877151842847;8244.381671374551;8261.463004904663;8358.080611132893;8822.735317940473;8834.690785822466;8849.336299777413;8876.644934202559;9005.504697241715;8019;8022;8176.509409435453;8502.14978502145;8689.956550217208;7404.259574042552;7581.696732130653;7610;7784.727534536264;7913.841723165389;7104;7254.383377412979;7523.962380188064;7671.578063206354;7713.4600577959 02:17:02 INFO - 2015-11-15 02:17:02,001 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:17:02 INFO - 2015-11-15 02:17:02,002 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:17:02 INFO - 2015-11-15 02:17:02,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 02:17:02 INFO - 2015-11-15 02:17:02,002 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:17:02 INFO - 2015-11-15 02:17:02,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1447582621987__endTimestamp 02:17:02 INFO - 2015-11-15 02:17:02,002 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:17:02 INFO - 2015-11-15 02:17:02,003 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:17:02 INFO - 2015-11-15 02:17:02,003 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,003 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4432.99 Median:4614.24 stddev:486.38 (10.5%) stddev-sans-first:464.83 02:17:02 INFO - 2015-11-15 02:17:02,004 DEBUG : BROWSER_OUTPUT: Values: 2547.3 2645.3 2665.9 2675.4 2681.7 4306.6 4393.8 4461.6 4493.0 4505.7 4375.8 4395.6 4423.7 4452.4 4543.0 3894.0 4054.9 4133.3 4159.8 4167.0 4142.7 4175.5 4203.6 4218.5 4256.3 3964.0 3967.4 4052.4 4077.2 4105.3 4080.7 4125.2 4152.6 4155.9 4159.0 4057.8 4068.4 4084.4 4126.3 4151.4 4254.1 4319.2 4388.3 4413.5 4539.0 4682.2 4684.6 4707.2 4755.0 4800.4 4625.1 4771.7 4827.3 4836.1 4861.2 4273.3 4274.3 4275.2 4397.3 4445.9 4795.6 4825.5 4837.2 4873.2 4989.4 4585.8 4591.5 4637.8 4644.7 4667.3 4634.5 4657.7 4718.8 4740.1 4744.9 4649.7 4674.7 4679.3 4737.2 4795.9 4677.6 4703.0 4746.1 4750.0 4789.1 3552.8 3585.0 3587.6 3648.5 3654.3 3229.3 3334.7 3358.1 3368.5 3420.5 4425.4 4444.9 4481.1 4502.2 4561.8 4750.0 4753.3 4827.5 4829.7 4885.9 4366.6 4408.5 4442.8 4455.5 4488.4 4119.5 4152.7 4191.9 4207.6 4209.6 4868.8 4921.6 4926.5 4936.2 5014.3 4645.7 4690.3 4718.8 4731.3 4903.4 4844.3 4906.4 4926.0 4939.7 4960.1 4666.9 4744.0 4751.5 4771.5 4811.2 4695.9 4712.2 4776.6 4784.4 4868.7 4568.2 4683.9 4692.5 4759.0 4785.3 4682.2 4725.5 4749.4 4763.5 4813.9 4440.6 4476.8 4525.2 4556.2 4708.6 4703.1 4731.2 4753.0 4794.1 4859.4 4614.2 4634.3 4670.2 4682.5 4731.7 02:17:02 INFO - 2015-11-15 02:17:02,005 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,006 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36656.66 Median:16115.71 stddev:59576.89 (369.7%) stddev-sans-first:59682.01 02:17:02 INFO - 2015-11-15 02:17:02,007 DEBUG : BROWSER_OUTPUT: Values: 453.9 472.8 474.8 475.4 490.9 26109.3 27038.1 27142.7 27260.0 32487.8 35329.3 35852.0 36025.0 36108.5 36164.0 7500.2 7549.8 7556.1 7616.4 7650.2 6869.7 6874.0 6980.5 7324.7 9033.0 9029.1 9045.0 9076.0 9156.2 9188.7 8327.2 9006.7 9025.1 9117.9 9125.2 6670.4 6782.6 6848.2 8880.8 9047.2 32648.0 32649.0 32722.3 33051.3 33098.2 2569.2 2836.5 2837.2 2899.1 2919.6 22697.2 22856.3 23068.7 23074.7 23358.6 1984.8 2015.5 2016.9 2050.1 2064.1 231188.0 232521.6 233539.0 235233.0 238354.0 48883.8 49284.5 49659.5 49768.5 49816.8 48265.0 50841.5 50899.5 53257.0 54578.5 11994.5 12056.5 12068.0 12085.9 12131.5 9011.2 9084.6 9114.4 9114.8 9177.4 15801.4 15927.0 16094.7 16322.1 16636.6 7021.3 7289.0 7339.9 7352.3 7411.6 730.9 753.6 788.2 910.8 913.8 21469.0 21768.9 21892.0 22027.8 22141.6 814.0 814.8 823.2 835.9 865.4 11353.8 11484.1 11500.0 11614.2 11663.9 202537.0 205555.0 205726.0 205771.6 209505.0 41042.4 41077.4 41136.8 41191.8 41206.8 1114.9 1124.8 1131.9 1143.1 1143.4 21866.1 22116.6 22439.4 22461.7 22614.9 38223.8 38711.0 38962.8 38976.4 39052.6 239133.0 241340.0 243670.0 245041.0 246426.0 22370.1 22937.3 24925.8 25283.5 26012.9 34208.1 34264.3 34542.8 34680.7 34920.8 27851.3 28458.0 29311.9 29425.7 29606.9 21149.9 26961.5 28151.4 28865.7 29126.4 27354.2 27987.4 28005.0 28144.7 28241.2 23573.7 24726.5 24778.9 25147.4 25452.4 18601.5 18987.1 19735.7 19930.9 20161.6 02:17:02 INFO - 2015-11-15 02:17:02,007 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,007 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20335.92 Median:4596.47 stddev:63649.12 (1384.7%) stddev-sans-first:63809.85 02:17:02 INFO - 2015-11-15 02:17:02,008 DEBUG : BROWSER_OUTPUT: Values: 279.7 280.8 281.8 282.4 286.8 14346.1 14743.5 14745.9 14789.3 15618.8 10746.8 10787.4 12688.6 14924.1 14992.9 4300.4 4443.8 4445.9 4474.4 4482.4 4145.5 4146.0 4162.6 4175.8 4208.2 3187.7 3288.5 3342.4 4718.2 4943.6 4875.9 4913.8 4926.0 4937.8 4943.2 4135.5 4201.0 4208.4 4213.5 4220.3 15352.8 15424.3 15682.0 17186.4 17409.4 1607.0 1708.9 1712.8 1749.7 1824.8 7625.7 7814.9 7945.9 7999.2 11226.1 1285.9 1305.5 1313.9 1335.1 1352.1 46442.0 47746.8 48291.3 48762.0 48872.2 5264.9 5293.3 5362.2 5379.1 5387.5 6041.4 6111.1 6133.7 6145.1 6169.1 4182.6 4325.2 4365.1 4366.2 4368.8 4572.1 4574.9 4580.7 4595.1 4597.8 2366.3 2450.5 2459.0 2480.1 2485.9 848.3 850.3 854.7 855.6 912.0 306.0 351.2 376.5 376.9 384.9 9328.7 9704.7 9844.3 9911.9 9994.9 354.4 357.9 369.6 372.7 382.4 5068.5 5074.4 5079.4 5167.2 5188.4 308421.0 309315.0 313854.0 478557.0 482199.0 58126.0 58547.0 58725.1 59376.4 60616.1 414.8 418.1 418.8 419.8 419.8 8882.7 8926.1 8941.9 8993.2 9054.8 27399.0 27600.4 27936.7 28528.0 28872.4 39715.0 39995.4 40240.0 40260.8 40905.2 4930.0 4972.9 5119.1 5138.8 5143.8 9384.0 9484.3 9693.2 9713.9 9780.5 7038.3 7339.4 7406.9 8466.4 8640.6 7079.0 8072.4 8171.8 8343.6 8432.3 8099.6 8354.9 8529.9 8546.7 8584.6 4998.3 5009.9 5012.9 5013.7 5088.5 7806.1 8317.8 8329.9 8514.7 8642.1 02:17:02 INFO - 2015-11-15 02:17:02,008 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,010 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4567.35 Median:5853.78 stddev:2381.59 (40.7%) stddev-sans-first:2374.65 02:17:02 INFO - 2015-11-15 02:17:02,010 DEBUG : BROWSER_OUTPUT: Values: 1178.6 1200.0 1279.0 1332.6 1514.9 5844.2 6005.1 6090.0 6094.5 6389.0 6173.6 6225.5 6225.6 6225.8 6297.1 1854.5 1854.7 1860.6 1886.5 1887.2 1882.5 1886.2 1900.8 1922.3 1951.8 1867.9 1878.2 1899.2 1900.8 1908.6 1809.4 1844.9 1847.9 1855.1 1858.1 1831.3 1854.2 1881.5 1882.0 1894.4 5847.3 6165.8 6175.7 6263.6 6292.1 3754.2 3842.3 3955.8 3988.3 4013.7 2389.3 2404.5 2429.4 2468.8 2474.0 772.5 780.8 785.9 829.4 838.9 8869.6 8884.2 8908.4 8943.9 8991.6 3697.3 3824.3 3834.4 3846.1 3881.8 7728.3 7779.5 7788.0 7807.2 7854.2 4252.4 4257.8 4271.6 4276.7 4298.7 3840.8 3854.4 3874.6 3885.3 3889.5 2959.4 2986.9 2992.8 3000.0 3017.1 980.3 981.3 981.8 983.8 994.6 1062.8 1071.7 1096.9 1098.6 1108.4 6186.0 6211.3 6215.3 6224.3 6293.2 394.9 399.4 400.6 405.7 406.6 4456.6 4456.9 4473.2 4523.3 4542.1 7329.4 7391.5 7664.0 7862.1 8143.9 7826.2 7828.1 7850.6 7913.2 7929.8 6078.1 6082.8 6170.0 6313.5 6331.7 5951.9 5992.6 6011.8 6025.2 6029.4 6837.8 6877.1 6978.1 6996.1 7032.5 7010.4 7295.3 7320.9 7330.0 7372.3 5771.7 5809.7 5814.6 5848.3 5859.3 5986.7 6192.1 6320.3 6406.6 6413.6 5923.9 5987.4 6045.2 6132.2 6195.2 5872.7 5964.3 5983.2 6027.0 6080.6 6007.3 6048.2 6065.4 6067.6 6113.1 5507.6 5509.4 5511.8 5558.1 5572.8 5568.9 5592.9 5610.4 5641.1 5642.6 02:17:02 INFO - 2015-11-15 02:17:02,010 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,010 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4571.19 Median:5295.87 stddev:1419.30 (26.8%) stddev-sans-first:1385.86 02:17:02 INFO - 2015-11-15 02:17:02,012 DEBUG : BROWSER_OUTPUT: Values: 257.9 259.3 263.0 265.4 265.9 5014.5 5162.7 5185.5 5193.2 5235.1 5022.7 5138.3 5139.0 5230.9 5252.3 3789.4 3837.2 3872.8 3945.9 3947.7 3819.2 3955.4 3958.6 3975.6 4004.3 3911.6 3920.1 3920.7 3953.4 3965.3 3904.4 3963.2 3968.4 3976.8 3981.2 3377.4 3396.9 3420.5 3423.9 3439.5 4902.3 5008.7 5066.4 5076.6 5118.0 4398.8 4414.9 4442.0 4459.7 4489.7 5349.5 5422.0 5430.5 5444.9 5459.3 3487.1 3581.3 3600.1 3703.5 3717.5 5589.9 5698.6 5754.3 5785.3 5786.6 3734.4 3742.9 3757.5 3789.2 3793.7 3790.1 3803.7 3816.3 3875.9 3881.7 4182.5 4407.4 4482.6 4487.7 4495.0 5416.7 5473.1 5485.7 5512.1 5525.6 1296.7 1299.6 1315.7 1316.3 1316.9 826.2 840.2 851.8 855.3 864.2 5256.7 5285.7 5292.7 5301.5 5322.3 5686.3 5707.3 5713.9 5732.8 5733.2 5269.4 5284.3 5295.0 5296.8 5299.8 2996.4 3048.1 3078.6 3092.3 3107.9 5879.4 5879.4 5886.4 5929.2 5965.9 5849.7 5870.1 5882.2 5887.5 5894.3 5860.4 5861.3 5874.6 5876.1 5905.4 5618.2 5760.0 5768.3 5781.0 5801.3 5427.1 5624.8 5643.3 5673.0 5688.3 5739.5 5757.1 5818.0 5933.8 5971.3 3660.9 3662.4 3697.4 3722.1 3728.2 5574.9 5673.0 5749.7 5755.1 5765.9 5333.1 5407.1 5514.5 5514.6 5550.3 5540.3 5564.4 5566.4 5591.8 5601.9 5359.5 5365.1 5387.3 5451.5 5471.7 5439.4 5464.7 5471.0 5531.1 5597.4 5360.0 5383.7 5425.8 5437.4 5447.7 02:17:02 INFO - 2015-11-15 02:17:02,012 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,012 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10843.12 Median:3132.94 stddev:12907.90 (412.0%) stddev-sans-first:12921.00 02:17:02 INFO - 2015-11-15 02:17:02,013 DEBUG : BROWSER_OUTPUT: Values: 559.3 588.0 605.1 617.1 628.4 11075.6 11302.0 11323.4 11463.0 11476.1 9182.6 9378.7 9396.4 9409.2 9519.0 691.1 709.9 710.0 721.0 721.7 737.8 739.8 746.7 752.0 762.7 771.8 777.9 783.3 788.1 790.1 767.9 770.0 777.4 780.3 786.1 564.2 564.3 566.3 569.9 574.6 11024.4 11220.8 11281.8 11323.4 11323.4 9358.7 9500.0 9716.7 10033.7 10219.6 6941.1 7199.1 7289.2 7391.4 7394.4 2697.4 2707.1 2771.9 2785.9 2828.7 34126.8 34695.7 35071.6 39251.0 39535.0 7251.4 7309.9 7496.6 7553.3 7721.9 15180.6 15281.8 15311.5 15314.5 15335.6 5557.2 5604.7 5691.3 5877.1 5967.1 3031.5 3123.3 3129.5 3178.3 3311.2 2446.8 2465.8 2490.6 2493.8 2494.7 355.1 358.4 359.4 362.1 369.9 368.2 409.2 439.5 457.2 520.4 6344.4 6605.9 6701.9 6761.7 6811.6 453.5 464.2 482.6 488.9 504.2 3094.1 3097.7 3150.3 3183.4 3185.7 44342.8 44416.6 49096.3 49517.3 49574.5 40933.0 40987.8 41117.6 41201.6 41298.0 30728.2 35743.0 36693.4 37043.6 37252.0 6308.7 6399.5 6453.8 6629.3 6865.3 28613.6 29230.6 29377.6 29394.3 29430.6 34571.5 37769.6 38414.2 38460.4 38569.6 5265.4 5897.4 5960.9 6046.5 6107.9 8712.6 8957.6 9233.3 9361.5 9428.0 7855.6 8189.9 8244.4 8261.5 8358.1 8822.7 8834.7 8849.3 8876.6 9005.5 8019.0 8022.0 8176.5 8502.1 8690.0 7404.3 7581.7 7610.0 7784.7 7913.8 7104.0 7254.4 7524.0 7671.6 7713.5 02:17:02 INFO - 2015-11-15 02:17:02,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:17:02 INFO - 2015-11-15 02:17:02,013 DEBUG : BROWSER_OUTPUT: 02:17:02 INFO - 2015-11-15 02:17:02,516 INFO : Browser exited with error code: 0 02:17:02 INFO - 2015-11-15 02:17:02,549 INFO : Completed test dromaeo_css (00:18:37) 02:17:02 INFO - 2015-11-15 02:17:02,549 INFO : Starting test kraken 02:17:02 INFO - 2015-11-15 02:17:02,549 DEBUG : operating with platform_type : mac_ 02:17:02 INFO - 2015-11-15 02:17:02,550 INFO : Initialising browser for kraken test... 02:17:02 INFO - 2015-11-15 02:17:02,567 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpjpLWAd/profile http://localhost:49266/getInfo.html 02:17:05 INFO - 2015-11-15 02:17:05,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:17:05 INFO - 2015-11-15 02:17:05,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:17:05 INFO - 2015-11-15 02:17:05,133 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:17:05 INFO - 2015-11-15 02:17:05,133 DEBUG : BROWSER_OUTPUT: __metrics 02:17:05 INFO - 2015-11-15 02:17:05,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:17:05 INFO - 2015-11-15 02:17:05,920 INFO : Browser initialized. 02:17:05 INFO - 2015-11-15 02:17:05,920 INFO : Running cycle 1/1 for kraken test... 02:17:05 INFO - 2015-11-15 02:17:05,921 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpjpLWAd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:17:18 INFO - 2015-11-15 02:17:18,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 230137856 02:17:18 INFO - 2015-11-15 02:17:18,098 DEBUG : BROWSER_OUTPUT: 02:17:21 INFO - 2015-11-15 02:17:21,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:21 INFO - 2015-11-15 02:17:21,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 286433280 02:17:21 INFO - 2015-11-15 02:17:21,674 DEBUG : BROWSER_OUTPUT: 02:17:24 INFO - 2015-11-15 02:17:24,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 02:17:25 INFO - 2015-11-15 02:17:25,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 297320448 02:17:25 INFO - 2015-11-15 02:17:25,375 DEBUG : BROWSER_OUTPUT: 02:17:28 INFO - 2015-11-15 02:17:28,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 02:17:29 INFO - 2015-11-15 02:17:29,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 282537984 02:17:29 INFO - 2015-11-15 02:17:29,420 DEBUG : BROWSER_OUTPUT: 02:17:31 INFO - 2015-11-15 02:17:31,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 02:17:32 INFO - 2015-11-15 02:17:32,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 284934144 02:17:32 INFO - 2015-11-15 02:17:32,337 DEBUG : BROWSER_OUTPUT: 02:17:34 INFO - 2015-11-15 02:17:34,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:35 INFO - 2015-11-15 02:17:35,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 285089792 02:17:35 INFO - 2015-11-15 02:17:35,460 DEBUG : BROWSER_OUTPUT: 02:17:39 INFO - 2015-11-15 02:17:39,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:39 INFO - 2015-11-15 02:17:39,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 281440256 02:17:39 INFO - 2015-11-15 02:17:39,615 DEBUG : BROWSER_OUTPUT: 02:17:43 INFO - 2015-11-15 02:17:43,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 02:17:43 INFO - 2015-11-15 02:17:43,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 279826432 02:17:43 INFO - 2015-11-15 02:17:43,932 DEBUG : BROWSER_OUTPUT: 02:17:47 INFO - 2015-11-15 02:17:47,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 02:17:47 INFO - 2015-11-15 02:17:47,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 281702400 02:17:47 INFO - 2015-11-15 02:17:47,841 DEBUG : BROWSER_OUTPUT: 02:17:49 INFO - 2015-11-15 02:17:49,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:50 INFO - 2015-11-15 02:17:50,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 317116416 02:17:50 INFO - 2015-11-15 02:17:50,174 DEBUG : BROWSER_OUTPUT: 02:17:52 INFO - 2015-11-15 02:17:52,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:52 INFO - 2015-11-15 02:17:52,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 320516096 02:17:52 INFO - 2015-11-15 02:17:52,896 DEBUG : BROWSER_OUTPUT: 02:17:55 INFO - 2015-11-15 02:17:55,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:17:55 INFO - 2015-11-15 02:17:55,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 326590464 02:17:55 INFO - 2015-11-15 02:17:55,891 DEBUG : BROWSER_OUTPUT: 02:17:58 INFO - 2015-11-15 02:17:58,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:17:59 INFO - 2015-11-15 02:17:59,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 327286784 02:17:59 INFO - 2015-11-15 02:17:59,496 DEBUG : BROWSER_OUTPUT: 02:18:02 INFO - 2015-11-15 02:18:02,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:18:03 INFO - 2015-11-15 02:18:03,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 326836224 02:18:03 INFO - 2015-11-15 02:18:03,177 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 02:18:05 INFO - 2015-11-15 02:18:05,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 386772992 02:18:05 INFO - 2015-11-15 02:18:05,391 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:18:05 INFO - 2015-11-15 02:18:05,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;134;130;131;133;141;144;131;130;133 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;189;159;195;209;157;184;179;164;207;155 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;196;197;196;196;197;199;197;197;197 02:18:05 INFO - 2015-11-15 02:18:05,392 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;101;102;150;87;89;87;85;132;82 02:18:05 INFO - 2015-11-15 02:18:05,393 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;120;116;167;109;109;112;162;114;112;158 02:18:05 INFO - 2015-11-15 02:18:05,393 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;148;141;148;148;142;141;148;141;141;141 02:18:05 INFO - 2015-11-15 02:18:05,393 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;155;155;155;155;155;154;163;155;154 02:18:05 INFO - 2015-11-15 02:18:05,393 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;126;121;120;114;124;114;130;119;124 02:18:05 INFO - 2015-11-15 02:18:05,394 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;69;72;73;72;74;74;82;71;72 02:18:05 INFO - 2015-11-15 02:18:05,394 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;79;85;84;87;85;86;86;86;85;86 02:18:05 INFO - 2015-11-15 02:18:05,394 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;105;106;105;109;110;110;105;105;106 02:18:05 INFO - 2015-11-15 02:18:05,394 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;160;158;161;151;160;153;157;156;153;151 02:18:05 INFO - 2015-11-15 02:18:05,394 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;178;187;194;191;193;172;186;188;185;188 02:18:05 INFO - 2015-11-15 02:18:05,395 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;85;87;86;85;86;86;87;88;86 02:18:05 INFO - 2015-11-15 02:18:05,395 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:18:05 INFO - 2015-11-15 02:18:05,395 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:18:05 INFO - 2015-11-15 02:18:05,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1015 02:18:05 INFO - 2015-11-15 02:18:05,395 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:18:05 INFO - 2015-11-15 02:18:05,396 DEBUG : BROWSER_OUTPUT: __startTimestamp1447582685387__endTimestamp 02:18:05 INFO - 2015-11-15 02:18:05,396 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,396 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:18:05 INFO - 2015-11-15 02:18:05,397 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:18:05 INFO - 2015-11-15 02:18:05,397 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,397 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:133.40 Median:133.00 stddev:5.23 (3.9%) stddev-sans-first:5.01 02:18:05 INFO - 2015-11-15 02:18:05,397 DEBUG : BROWSER_OUTPUT: Values: 127.0 134.0 130.0 131.0 133.0 141.0 144.0 131.0 130.0 133.0 02:18:05 INFO - 2015-11-15 02:18:05,397 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.80 Median:186.50 stddev:20.39 (10.9%) stddev-sans-first:21.36 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: Values: 189.0 159.0 195.0 209.0 157.0 184.0 179.0 164.0 207.0 155.0 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.40 Median:197.00 stddev:1.78 (0.9%) stddev-sans-first:0.93 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: Values: 192.0 196.0 197.0 196.0 196.0 197.0 199.0 197.0 197.0 197.0 02:18:05 INFO - 2015-11-15 02:18:05,398 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,399 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.50 Median:86.00 stddev:22.69 (26.4%) stddev-sans-first:23.75 02:18:05 INFO - 2015-11-15 02:18:05,399 DEBUG : BROWSER_OUTPUT: Values: 90.0 101.0 102.0 150.0 87.0 89.0 87.0 85.0 132.0 82.0 02:18:05 INFO - 2015-11-15 02:18:05,399 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,399 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:127.90 Median:118.00 stddev:24.07 (20.4%) stddev-sans-first:25.36 02:18:05 INFO - 2015-11-15 02:18:05,399 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 167.0 109.0 109.0 112.0 162.0 114.0 112.0 158.0 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.90 Median:145.00 stddev:3.54 (2.4%) stddev-sans-first:3.43 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: Values: 148.0 141.0 148.0 148.0 142.0 141.0 148.0 141.0 141.0 141.0 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.90 Median:155.00 stddev:3.57 (2.3%) stddev-sans-first:2.78 02:18:05 INFO - 2015-11-15 02:18:05,400 DEBUG : BROWSER_OUTPUT: Values: 148.0 155.0 155.0 155.0 155.0 155.0 154.0 163.0 155.0 154.0 02:18:05 INFO - 2015-11-15 02:18:05,401 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,401 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:120.30 Median:122.50 stddev:5.98 (4.9%) stddev-sans-first:5.32 02:18:05 INFO - 2015-11-15 02:18:05,401 DEBUG : BROWSER_OUTPUT: Values: 111.0 126.0 121.0 120.0 114.0 124.0 114.0 130.0 119.0 124.0 02:18:05 INFO - 2015-11-15 02:18:05,401 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,401 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.50 stddev:3.95 (5.4%) stddev-sans-first:3.63 02:18:05 INFO - 2015-11-15 02:18:05,402 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 72.0 73.0 72.0 74.0 74.0 82.0 71.0 72.0 02:18:05 INFO - 2015-11-15 02:18:05,402 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,402 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.90 Median:86.00 stddev:2.23 (2.6%) stddev-sans-first:0.88 02:18:05 INFO - 2015-11-15 02:18:05,402 DEBUG : BROWSER_OUTPUT: Values: 79.0 85.0 84.0 87.0 85.0 86.0 86.0 86.0 85.0 86.0 02:18:05 INFO - 2015-11-15 02:18:05,402 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.80 Median:107.50 stddev:3.74 (3.5%) stddev-sans-first:2.22 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: Values: 97.0 105.0 106.0 105.0 109.0 110.0 110.0 105.0 105.0 106.0 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:157.50 stddev:3.80 (2.4%) stddev-sans-first:3.75 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: Values: 160.0 158.0 161.0 151.0 160.0 153.0 157.0 156.0 153.0 151.0 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,404 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:188.00 stddev:6.73 (3.6%) stddev-sans-first:6.45 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: Values: 178.0 187.0 194.0 191.0 193.0 172.0 186.0 188.0 185.0 188.0 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:86.00 stddev:2.76 (3.2%) stddev-sans-first:0.97 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: Values: 78.0 85.0 87.0 86.0 85.0 86.0 86.0 87.0 88.0 86.0 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:18:05 INFO - 2015-11-15 02:18:05,405 DEBUG : BROWSER_OUTPUT: 02:18:06 INFO - 2015-11-15 02:18:06,149 INFO : Browser exited with error code: 0 02:18:06 INFO - 2015-11-15 02:18:06,206 INFO : Completed test kraken (00:01:03) 02:18:06 INFO - 2015-11-15 02:18:06,206 INFO : Starting test v8_7 02:18:06 INFO - 2015-11-15 02:18:06,206 DEBUG : operating with platform_type : mac_ 02:18:06 INFO - 2015-11-15 02:18:06,207 INFO : Initialising browser for v8_7 test... 02:18:06 INFO - 2015-11-15 02:18:06,224 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpCtLv8o/profile http://localhost:49266/getInfo.html 02:18:08 INFO - 2015-11-15 02:18:08,740 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:18:08 INFO - 2015-11-15 02:18:08,740 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:18:08 INFO - 2015-11-15 02:18:08,741 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:18:08 INFO - 2015-11-15 02:18:08,741 DEBUG : BROWSER_OUTPUT: __metrics 02:18:08 INFO - 2015-11-15 02:18:08,756 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:09 INFO - 2015-11-15 02:18:09,582 INFO : Browser initialized. 02:18:09 INFO - 2015-11-15 02:18:09,582 INFO : Running cycle 1/1 for v8_7 test... 02:18:09 INFO - 2015-11-15 02:18:09,582 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpCtLv8o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:18:21 INFO - 2015-11-15 02:18:21,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 228556800 02:18:21 INFO - 2015-11-15 02:18:21,732 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 02:18:44 INFO - 2015-11-15 02:18:44,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 756072448 02:18:44 INFO - 2015-11-15 02:18:44,898 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,898 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:18:44 INFO - 2015-11-15 02:18:44,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |0;Richards;202.26537216828478 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;235.23876734885908 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |2;Encrypt;387.74718883288097 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6924.137931034483 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2383.3333333333335 02:18:44 INFO - 2015-11-15 02:18:44,899 DEBUG : BROWSER_OUTPUT: |5;Earley;976.5625 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: |6;Boyer;15781.25 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: |7;RegExp;36392.857142857145 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: |8;Splay;819.000819000819 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7063.380281690141 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: __startTimestamp1447582724890__endTimestamp 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,900 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:202.27 Median:202.27 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: Values: 202.3 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:235.24 Median:235.24 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: Values: 235.2 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:387.75 Median:387.75 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: Values: 387.7 02:18:44 INFO - 2015-11-15 02:18:44,901 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6924.14 Median:6924.14 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: Values: 6924.1 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2383.33 Median:2383.33 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: Values: 2383.3 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:976.56 Median:976.56 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: Values: 976.6 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15781.25 Median:15781.25 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: Values: 15781.3 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36392.86 Median:36392.86 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,902 DEBUG : BROWSER_OUTPUT: Values: 36392.9 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:819.00 Median:819.00 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: Values: 819.0 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7063.38 Median:7063.38 stddev:0.00 (0.0%) 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: Values: 7063.4 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:18:44 INFO - 2015-11-15 02:18:44,903 DEBUG : BROWSER_OUTPUT: 02:18:45 INFO - 2015-11-15 02:18:45,683 INFO : Browser exited with error code: 0 02:18:45 INFO - 2015-11-15 02:18:45,707 INFO : Completed test v8_7 (00:00:39) 02:18:46 INFO - 2015-11-15 02:18:46,122 INFO : Completed test suite (00:20:20) 02:18:46 INFO - 2015-11-15 02:18:46,122 DEBUG : Working with test: dromaeo_css 02:18:46 INFO - 2015-11-15 02:18:46,122 DEBUG : Generating results file: dromaeo_css 02:18:46 INFO - 2015-11-15 02:18:46,123 DEBUG : Working with test: kraken 02:18:46 INFO - 2015-11-15 02:18:46,123 DEBUG : Generating results file: kraken 02:18:46 INFO - 2015-11-15 02:18:46,123 INFO : javascript benchmark 02:18:46 INFO - 2015-11-15 02:18:46,123 DEBUG : Working with test: v8_7 02:18:46 INFO - 2015-11-15 02:18:46,123 DEBUG : Generating results file: v8_7 02:18:46 INFO - 2015-11-15 02:18:46,123 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:46 INFO - 2015-11-15 02:18:46,174 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 02:18:46 INFO - 2015-11-15 02:18:46,174 DEBUG : process_Request line: dromaeo_css 5487.10 graph.html#tests=[[72,63,55]] 02:18:46 INFO - 2015-11-15 02:18:46,174 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:46 INFO - 2015-11-15 02:18:46,202 DEBUG : process_Request line: kraken 1848.00 graph.html#tests=[[232,63,55]] 02:18:46 INFO - 2015-11-15 02:18:46,202 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:18:46 INFO - 2015-11-15 02:18:46,236 DEBUG : process_Request line: v8_7 15154.72 graph.html#tests=[[230,63,55]] 02:18:46 INFO - 2015-11-15 02:18:46,237 INFO : javascript benchmark 02:18:46 INFO - 2015-11-15 02:18:46,239 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [279.72586864872414, 280.78239364492526, 281.77598808946885, 282.40553634599166, 286.78634417359063, 14346.139231646108, 14743.48397806077, 14745.852541474582, 14789.260536973148, 15618.76571851423, 10746.838797418026, 10787.352758834475, 12688.555900543459, 14924.104553726784, 14992.850071499282, 4300.35494675798, 4443.800028998687, 4445.888852778674, 4474.418325617665, 4482.350059241425, 4145.481814773153, 4146.046409325857, 4162.625363717265, 4175.832966681344, 4208.242516347056, 3187.7449804015737, 3288.457404528262, 3342.3649506593792, 4718.150732868083, 4943.604511639061, 4875.926861097087, 4913.803447862081, 4926.0394223126505, 4937.80248790048, 4943.159662857305, 4135.462389889325, 4201.0, 4208.3687446882905, 4213.536510983789, 4220.261454245526, 15352.846471535253, 15424.305906234247, 15682.0, 17186.398476053404, 17409.390671326444, 1606.9678606427924, 1708.92309846056, 1712.7859017622798, 1749.7287920372362, 1824.8175182481777, 7625.694972201105, 7814.882776758353, 7945.88081178777, 7999.200079992012, 11226.101911847032, 1285.9292738899358, 1305.484333688188, 1313.8620444853248, 1335.132164093347, 1352.134633834347, 46442.0, 47746.76126619414, 48291.275630865566, 48762.0, 48872.18045112765, 5264.947350526446, 5293.285406470077, 5362.195670649356, 5379.085555455504, 5387.46125387466, 6041.395860414012, 6111.083337499322, 6133.662648554283, 6145.139680444741, 6169.074638804215, 4182.560831112689, 4325.2214601371425, 4365.06151177492, 4366.19225443294, 4368.847090351886, 4572.108438854391, 4574.885627859264, 4580.702254353457, 4595.149897268949, 4597.793099310539, 2366.290112966103, 2450.47314827313, 2458.9672337618244, 2480.1071614218868, 2485.8632775197175, 848.253536887535, 850.3282406898604, 854.6538651846013, 855.6064210463132, 912.0469109780296, 305.9541068839692, 351.206273821166, 376.4597802153918, 376.91121261264226, 384.9230153969161, 9328.673496427593, 9704.70885873425, 9844.310898237054, 9911.851322230172, 9994.850077248848, 354.4134457472887, 357.8604344305723, 369.62852333405294, 372.7428074628498, 382.4110869261306, 5068.518490743373, 5074.3657042869645, 5079.415867175248, 5167.199084141889, 5188.429272779991, 308421.0, 309315.0, 313854.0, 478557.0, 482199.0, 58126.0, 58547.0, 58725.11912321319, 59376.40623593709, 60616.09075863865, 414.80089557012803, 418.14489369239976, 418.8052555561678, 419.7628339987897, 419.8005947175067, 8882.689105881263, 8926.062763410007, 8941.876306872267, 8993.235574976201, 9054.81890362176, 27399.0, 27600.447991039666, 27936.72063279341, 28528.0, 28872.422551548432, 39715.0, 39995.400068999574, 40240.0, 40260.79869600751, 40905.18189636131, 4930.0, 4972.9254061188385, 5119.078565858033, 5138.820141295037, 5143.794248230029, 9384.0, 9484.288678349014, 9693.176080033276, 9713.854292185482, 9780.510974451106, 7038.331358520933, 7339.412846972336, 7406.851862962602, 8466.449680770731, 8640.611172497127, 7079.0, 8072.394570407126, 8171.79570510742, 8343.624536895975, 8432.283255923316, 8099.595020249082, 8354.874676879974, 8529.872051919103, 8546.743597692079, 8584.613692383733, 4998.275250088789, 5009.949900501094, 5012.899742005213, 5013.674111182761, 5088.542031217208, 7806.102298235775, 8317.83364332722, 8329.916700832913, 8514.659413623633, 8642.135786421308], "dojo.html": [2547.299492639524, 2645.2725500487363, 2665.933351666208, 2675.3712877473804, 2681.7318268173185, 4306.61240488356, 4393.780310984446, 4461.553844615537, 4493.0, 4505.729656220625, 4375.846845360421, 4395.560443955603, 4423.66822488313, 4452.421185245914, 4542.954570454294, 3893.9820717807534, 4054.858079967202, 4133.318002529579, 4159.771212583307, 4166.979165104185, 4142.71001029928, 4175.54069052404, 4203.558626344236, 4218.472690913636, 4256.318988961767, 3963.960360396388, 3967.4247234150885, 4052.4124002019835, 4077.245709543744, 4105.281575724266, 4080.738694342822, 4125.1749650070105, 4152.584741525853, 4155.854545090907, 4159.022629682053, 4057.797110144481, 4068.4304197412384, 4084.36692312692, 4126.319157339036, 4151.356539736345, 4254.127903779718, 4319.222539942809, 4388.319810429389, 4413.470383553994, 4538.9546104539195, 4682.204025315705, 4684.625229981593, 4707.246840505537, 4755.0, 4800.375951126366, 4625.074985002979, 4771.713697178146, 4827.25177597473, 4836.056968891067, 4861.2041378283775, 4273.273543497613, 4274.337477690963, 4275.187714334266, 4397.2964325707735, 4445.866624001285, 4795.568398844121, 4825.517448255217, 4837.153498137882, 4873.244647079709, 4989.426215985208, 4585.816567337336, 4591.494935557086, 4637.814487420465, 4644.7213167210075, 4667.323238130452, 4634.536546345338, 4657.720536767804, 4718.834840780556, 4740.099381117577, 4744.881377965578, 4649.697769644962, 4674.719516829001, 4679.251319788817, 4737.194676904935, 4795.904081918342, 4677.6257899367965, 4703.035877645075, 4746.050789842046, 4750.0, 4789.090072886141, 3552.751307408457, 3584.98207508966, 3587.6412358763914, 3648.52569166012, 3654.3056819204267, 3229.273413481948, 3334.6665333466945, 3358.143673363277, 3368.494725791151, 3420.4698271767916, 4425.380446737459, 4444.888877778017, 4481.126180394857, 4502.234620114523, 4561.794719237576, 4749.95250047502, 4753.263244197155, 4827.517248275215, 4829.710217386898, 4885.853424397274, 4366.607005369532, 4408.493023302297, 4442.755648439367, 4455.4876189238, 4488.4165058542185, 4119.526254480713, 4152.709310348247, 4191.937120943188, 4207.579242075829, 4209.6000879916355, 4868.78090485929, 4921.581665558468, 4926.531979461945, 4936.234883592905, 5014.2979982802435, 4645.698029628198, 4690.343351930801, 4718.834840780693, 4731.29030645406, 4903.362562866804, 4844.270031295074, 4906.362172917497, 4926.039422312615, 4939.703617782944, 4960.082384758831, 4666.859994200179, 4744.003759210605, 4751.50109238525, 4771.475137734916, 4811.230203167476, 4695.882602934954, 4712.246040633482, 4776.59398951093, 4784.449788274393, 4868.683535570177, 4568.200564901195, 4683.929741053955, 4692.50728673498, 4758.952410475851, 4785.258284965836, 4682.22743247374, 4725.456572494069, 4749.430068391677, 4763.476017637988, 4813.855584332476, 4440.6447484201835, 4476.753778542081, 4525.162844873709, 4556.202664533627, 4708.576228139484, 4703.129920964632, 4731.219348807408, 4753.049390122059, 4794.089123066607, 4859.392575928009, 4614.238650622609, 4634.281686338623, 4670.182718024264, 4682.531746825291, 4731.69243999139], "mootools.html": [1178.611058350744, 1199.9820002699962, 1279.0, 1332.5735764555343, 1514.856088671576, 5844.181814545962, 6005.12925625784, 6090.0, 6094.51243900488, 6389.0416437534395, 6173.567850250484, 6225.470834979021, 6225.564210505267, 6225.813225603228, 6297.118403423525, 1854.4714756294459, 1854.7310639957198, 1860.6185731924922, 1886.518937670892, 1887.1790771014653, 1882.491727233646, 1886.1795119123158, 1900.8479321654304, 1922.2695375757194, 1951.804819518051, 1867.8972656503886, 1878.2111513164505, 1899.154876080145, 1900.7624046994126, 1908.5610309628794, 1809.4481183239106, 1844.8800827946209, 1847.861410394226, 1855.1373611270756, 1858.1266804601817, 1831.2949514436905, 1854.2026928420773, 1881.4543782303115, 1882.0, 1894.4032629721733, 5847.26909136358, 6165.815025549241, 6175.66033868137, 6263.6241825490615, 6292.087647291163, 3754.1928485375774, 3842.289176502356, 3955.7626542407547, 3988.3219852624834, 4013.7190396671954, 2389.330987323552, 2404.483036147237, 2429.4290841652196, 2468.7654672806057, 2473.9628905566433, 772.5287574579502, 780.8282177920848, 785.9449838511307, 829.357248132696, 838.9203025712548, 8869.645214191425, 8884.244839188677, 8908.420952638058, 8943.910560894374, 8991.59537820793, 3697.2790305890094, 3824.349860523718, 3834.405667121601, 3846.1346197105427, 3881.7865017424315, 7728.343090837229, 7779.45543811939, 7788.0, 7807.219278072261, 7854.214578542214, 4252.362145678111, 4257.787110644517, 4271.594198551133, 4276.743395396286, 4298.677599180074, 3840.846366145379, 3854.402567602026, 3874.6319099686048, 3885.2812229737588, 3889.533256009297, 2959.4081183763333, 2986.865591048408, 2992.8353940533043, 2999.9550006749914, 3017.0797906638686, 980.3088822380205, 981.2836629260537, 981.8232718110665, 983.7934033852828, 994.5872462927804, 1062.8352605346183, 1071.6624263357019, 1096.9396683182342, 1098.5825386353135, 1108.4014632098576, 6186.041163619646, 6211.3167551569295, 6215.34738852423, 6224.346443623445, 6293.181886354836, 394.87364043506375, 399.4427773256291, 400.56938790800007, 405.71599880084057, 406.595437539644, 4456.598906098467, 4456.888577785517, 4473.150101480708, 4523.32150177476, 4542.136993971135, 7329.377002954702, 7391.519551229153, 7664.0, 7862.095858976177, 8143.877841832377, 7826.178251283647, 7828.060632724109, 7850.56821874791, 7913.248241417056, 7929.762107136795, 6078.1186727924205, 6082.787102451393, 6170.0, 6313.494920406449, 6331.68341582919, 5951.851203719942, 5992.580519363777, 6011.789587364421, 6025.21672182631, 6029.397060293935, 6837.811900191891, 6877.071595334566, 6978.127734033246, 6996.090508233897, 7032.472564557781, 7010.369066784014, 7295.306945840137, 7320.865265883796, 7329.963350183215, 7372.262773722585, 5771.653700777799, 5809.738561764815, 5814.563907707024, 5848.2689663792025, 5859.296884373903, 5986.700664966647, 6192.133101365903, 6320.273168585672, 6406.583572067801, 6413.583117097373, 5923.881522369615, 5987.43119403656, 6045.183900173421, 6132.202813634199, 6195.2255968004, 5872.706364681834, 5964.343922168471, 5983.192269043623, 6026.969865150646, 6080.574359794772, 6007.339192688713, 6048.183495228088, 6065.363136870565, 6067.605605635619, 6113.113598528277, 5507.614466987273, 5509.3664228612615, 5511.751971161388, 5558.082916318924, 5572.777088916398, 5568.888622227451, 5592.916106258328, 5610.410906854885, 5641.12562552805, 5642.576806739429], "ext.html": [453.86837817033063, 472.7754316699568, 474.75075585317705, 475.43185892858025, 490.87728067983005, 26109.347266318353, 27038.053668121596, 27142.728572714266, 27260.0, 32487.837560812222, 35329.29341413177, 35852.0, 36025.0, 36108.45837312443, 36164.0, 7500.174980752126, 7549.811254718648, 7556.055493063367, 7616.3906887448875, 7650.158482566913, 6869.690863911136, 6873.965630171842, 6980.476464265175, 7324.707011719524, 9033.0, 9029.097090290985, 9044.954775226148, 9075.95462022689, 9156.22172115371, 9188.724338269829, 8327.167283271685, 9006.684766033222, 9025.052369501174, 9117.908820911773, 9125.178733913946, 6670.366315200048, 6782.626955517445, 6848.246692863781, 8880.777980550538, 9047.230985366252, 32648.0, 32649.0, 32722.345553089042, 33051.3389732204, 33098.17254568631, 2569.216389001354, 2836.546152615572, 2837.163036904118, 2899.057806212968, 2919.5620656901424, 22697.205597803997, 22856.31431057071, 23068.653970190462, 23074.65388019181, 23358.64962025571, 1984.7717512486104, 2015.54650203703, 2016.9495762605904, 2050.0672194151625, 2064.112431654388, 231188.0, 232521.60958270586, 233539.0, 235233.0, 238354.0, 48883.75558122258, 49284.50715492871, 49659.50340496621, 49768.50231497711, 49816.75091624591, 48265.0, 50841.49158508368, 50899.491005089476, 53257.0, 54578.45421545813, 11994.460249288803, 12056.51773929033, 12068.0, 12085.879141208476, 12131.454084566216, 9011.234045106108, 9084.636614535344, 9114.36199466031, 9114.772130696785, 9177.449353038839, 15801.36794528206, 15926.97387496372, 16094.678106437806, 16322.102284374474, 16636.58408539772, 7021.297870212938, 7288.96355518219, 7339.926600734031, 7352.338289553966, 7411.592362420119, 730.9269073092754, 753.5591678867814, 788.1802924958095, 910.8360495110944, 913.8081002989446, 21469.0, 21768.89115554412, 21892.014859331368, 22027.779722202893, 22141.557168856856, 813.9918600813916, 814.7515007922522, 823.2343920154194, 835.8913341265718, 865.4244927123392, 11353.772924541463, 11484.138689598314, 11500.0, 11614.245074070328, 11663.941680291713, 202537.0, 205555.0, 205726.0, 205771.56713246566, 209505.0, 41042.38436423456, 41077.38383924244, 41136.79431602823, 41191.7940410296, 41206.793966029974, 1114.8717897441736, 1124.7637996020765, 1131.909447244235, 1143.085531574737, 1143.4454289669504, 21866.125354985623, 22116.55766884621, 22439.43901402478, 22461.66307505356, 22614.886925565268, 38223.80888095542, 38711.0, 38962.80518597389, 38976.41535377028, 39052.6094739049, 239133.0, 241340.0, 243670.0, 245041.0, 246426.0, 22370.105195791984, 22937.311880643607, 24925.750742492342, 25283.494330113663, 26012.869935650957, 34208.14479638029, 34264.31471370509, 34542.82728586341, 34680.65319346875, 34920.82539587286, 27851.303717407227, 28458.0, 29311.85344073266, 29425.70574294315, 29606.851965740032, 21149.89425052865, 26961.46077078408, 28151.43697126087, 28865.7113428863, 29126.41747165087, 27354.179374618794, 27987.440251194454, 28005.0, 28144.71855281421, 28241.15276541707, 23573.69591841822, 24726.50546989086, 24778.876105619358, 25147.371315717253, 25452.363690907136, 18601.53496162607, 18987.140342327446, 19735.703964440258, 19930.90034549818, 20161.596768064264], "prototype.html": [257.8517352522299, 259.25464290165775, 263.03728354223546, 265.4491929246813, 265.9428222932069, 5014.548690617844, 5162.716050617215, 5185.481451854813, 5193.195054766513, 5235.057689615873, 5022.698638081709, 5138.2806407103035, 5139.0, 5230.8692282692955, 5252.343457067866, 3789.431585262219, 3837.2325534892993, 3872.8063596820048, 3945.9013524661827, 3947.703922205839, 3819.236152769457, 3955.4462375267485, 3958.584348643394, 3975.642192202701, 4004.339284018148, 3911.550171730259, 3920.0787814863484, 3920.745151565139, 3953.3872249801184, 3965.266425711253, 3904.4338570907344, 3963.2073585282915, 3968.444417781513, 3976.8210430530694, 3981.163955569348, 3377.4089534331392, 3396.8641254349795, 3420.538227339302, 3423.8972830815114, 3439.518467414564, 4902.313676085351, 5008.749562521859, 5066.417362003343, 5076.6192535559985, 5118.027574760821, 4398.846040388603, 4414.889627759299, 4442.044960333512, 4459.710118842265, 4489.685721999462, 5349.465053494659, 5421.972890135524, 5430.484104010113, 5444.863878403032, 5459.344878614552, 3487.075924879909, 3581.3374525712825, 3600.0999750062483, 3703.5000274962804, 3717.4609681596016, 5589.944100559023, 5698.629589076738, 5754.251947246873, 5785.334686511021, 5786.623869448515, 3734.439834024918, 3742.8502859885843, 3757.492738480325, 3789.204267103884, 3793.696504279651, 3790.1282704977457, 3803.714721395851, 3816.2939856126704, 3875.922481550353, 3881.7476864003747, 4182.519010313792, 4407.4050003249795, 4482.596566309048, 4487.685861989629, 4495.011097558598, 5416.702081385482, 5473.0969390050195, 5485.725713714299, 5512.062949298629, 5525.640833345819, 1296.6887946892866, 1299.6231092983119, 1315.6973896003972, 1316.2957817567556, 1316.8551459339465, 826.2150956591263, 840.2102024097329, 851.7998270406449, 855.341387131905, 864.1747131489412, 5256.658317209369, 5285.68285902847, 5292.655977361459, 5301.469853014668, 5322.281491998608, 5686.2607860977805, 5707.286589176353, 5713.885722285614, 5732.7706891723865, 5733.168690539848, 5269.446708095595, 5284.260203571503, 5294.97352513235, 5296.761645725875, 5299.814506492255, 2996.4361094772134, 3048.085574327693, 3078.599782028322, 3092.304231547884, 3107.90676279712, 5879.412058794086, 5879.441453061952, 5886.352501224862, 5929.199558059693, 5965.940340596625, 5849.6782676952325, 5870.0607902735355, 5882.205902203234, 5887.528997680175, 5894.292684877756, 5860.413958604106, 5861.267341582302, 5874.559408044413, 5876.059830427112, 5905.43898329658, 5618.185363122243, 5760.0, 5768.336641286306, 5781.0, 5801.332846722681, 5427.05026620332, 5624.775008999594, 5643.26637537134, 5672.971635141798, 5688.260526131577, 5739.512141467855, 5757.107648314351, 5818.0, 5933.821985340447, 5971.313298970674, 3660.890173294805, 3662.414013757786, 3697.4084146537502, 3722.050877026341, 3728.2357116791536, 5574.944250557604, 5673.0, 5749.741261643152, 5755.050416681368, 5765.91351129725, 5333.066713325075, 5407.0537655909275, 5514.476124768141, 5514.61397702157, 5550.27846379968, 5540.335159780852, 5564.415736347625, 5566.443355664401, 5591.832245032656, 5601.915971260353, 5359.517643412111, 5365.061114304903, 5387.299651045339, 5451.509364157245, 5471.699056551769, 5439.401665816677, 5464.672119672832, 5471.015217260931, 5531.115021596525, 5597.440255974533, 5360.0, 5383.7308134593895, 5425.782968681208, 5437.3747019091725, 5447.727613619382], "yui.html": [559.3036669346664, 588.0238803586049, 605.1104875832525, 617.0774691835705, 628.3841835001699, 11075.556977720891, 11302.0, 11323.433828308573, 11463.0, 11476.139289553275, 9182.586783594737, 9378.718638440841, 9396.38923469974, 9409.153176214139, 9519.0, 691.0981169573704, 709.8615769924867, 710.0059916117425, 721.0122132678238, 721.6968873073296, 737.8118579762153, 739.7521830186894, 746.7423738810129, 751.9548827070366, 762.6529928882345, 771.8301973565807, 777.8794286885542, 783.2519943454016, 788.1369899959535, 790.119017295714, 767.8848172774073, 770.0143815915637, 777.3975169243824, 780.321120625057, 786.1313248860013, 564.2129229724552, 564.2608183279875, 566.2695123290949, 569.8746275819354, 574.6264927796924, 11024.393658348788, 11220.831687524693, 11281.830772538418, 11323.377214253213, 11323.377214253213, 9358.672446464408, 9500.0, 9716.708498745049, 10033.698989030341, 10219.642312519027, 6941.132358455193, 7199.136103667541, 7289.2346303638415, 7391.445641576904, 7394.408447324255, 2697.4335389568214, 2707.120185939558, 2771.9445611087867, 2785.9442811143867, 2828.6747024092083, 34126.82936585326, 34695.653043469494, 35071.6492835071, 39251.0, 39534.99999999971, 7251.3836323912, 7309.89035164473, 7496.58768767723, 7553.282438168365, 7721.92278077212, 15180.620484487976, 15281.847181528265, 15311.540653780181, 15314.463993760164, 15335.61660958485, 5557.221988921554, 5604.6917419541505, 5691.26013618227, 5877.059670452707, 5967.1347654589845, 3031.4998025326017, 3123.32848437587, 3129.530570414456, 3178.3166619176986, 3311.172206948263, 2446.8287219894437, 2465.815063870217, 2490.638857365672, 2493.8379005364595, 2494.663220465214, 355.1334743226519, 358.36390407027216, 359.44286356147865, 362.0640643935456, 369.88718440875255, 368.1899820395141, 409.18776229185045, 439.45946485822617, 457.1884904294837, 520.4145336496441, 6344.397282258178, 6605.86788264232, 6701.927726459188, 6761.684451409118, 6811.591304521745, 453.45358842594595, 464.2386486162696, 482.5512273585529, 488.94866039066096, 504.19329073482135, 3094.05631282461, 3097.7057179567905, 3150.291184483473, 3183.4428974929297, 3185.7132858042887, 44342.77828610836, 44416.55583444124, 49096.26355604669, 49517.257241141415, 49574.50425495699, 40933.0, 40987.7950610251, 41117.588824111976, 41201.58798412037, 41298.0, 30728.231794205323, 35743.0, 36693.44959825605, 37043.629563704555, 37252.0, 6308.71610777507, 6399.488040956805, 6453.838654033687, 6629.303923088007, 6865.313468653095, 28613.570796437652, 29230.561541577317, 29377.559336610397, 29394.265143371587, 29430.558541622322, 34571.48142777911, 37769.62230377661, 38414.23171536609, 38460.42309365418, 38569.6143038566, 5265.420803711665, 5897.3807750185615, 5960.850978725566, 6046.486048685911, 6107.908381374372, 8712.607932642919, 8957.552122393723, 9233.261339092722, 9361.531923403667, 9428.0, 7855.646495907584, 8189.877151842847, 8244.381671374551, 8261.463004904663, 8358.080611132893, 8822.735317940473, 8834.690785822466, 8849.336299777413, 8876.644934202559, 9005.504697241715, 8019.0, 8022.0, 8176.509409435453, 8502.14978502145, 8689.956550217208, 7404.259574042552, 7581.696732130653, 7610.0, 7784.727534536264, 7913.841723165389, 7104.0, 7254.383377412979, 7523.962380188064, 7671.578063206354, 7713.4600577959]}, "summary": {"lowerIsBetter": false, "suite": 5487.102745568494, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5639.472338396193, "unit": "ms", "value": 5639.472338396193}, "dojo.html": {"lowerIsBetter": false, "filtered": 4401.777020118829, "unit": "ms", "value": 4401.777020118829}, "mootools.html": {"lowerIsBetter": false, "filtered": 3682.119497235019, "unit": "ms", "value": 3682.119497235019}, "ext.html": {"lowerIsBetter": false, "filtered": 14891.623205603199, "unit": "ms", "value": 14891.623205603199}, "prototype.html": {"lowerIsBetter": false, "filtered": 4092.527724201435, "unit": "ms", "value": 4092.527724201435}, "yui.html": {"lowerIsBetter": false, "filtered": 4899.117435887563, "unit": "ms", "value": 4899.117435887563}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447581505, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115004216", "branch": "Mozilla-Inbound", "revision": "694f70dd36857b0c504b3feddf7538fb94797654"}}, {"talos_counters": {}, "results": {"audio-dft": [192.0, 196.0, 197.0, 196.0, 196.0, 197.0, 199.0, 197.0, 197.0, 197.0], "ai-astar": [127.0, 134.0, 130.0, 131.0, 133.0, 141.0, 144.0, 131.0, 130.0, 133.0], "imaging-gaussian-blur": [148.0, 141.0, 148.0, 148.0, 142.0, 141.0, 148.0, 141.0, 141.0, 141.0], "audio-beat-detection": [189.0, 159.0, 195.0, 209.0, 157.0, 184.0, 179.0, 164.0, 207.0, 155.0], "json-stringify-tinderbox": [79.0, 85.0, 84.0, 87.0, 85.0, 86.0, 86.0, 86.0, 85.0, 86.0], "stanford-crypto-pbkdf2": [178.0, 187.0, 194.0, 191.0, 193.0, 172.0, 186.0, 188.0, 185.0, 188.0], "json-parse-financial": [67.0, 69.0, 72.0, 73.0, 72.0, 74.0, 74.0, 82.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [78.0, 85.0, 87.0, 86.0, 85.0, 86.0, 86.0, 87.0, 88.0, 86.0], "audio-fft": [90.0, 101.0, 102.0, 150.0, 87.0, 89.0, 87.0, 85.0, 132.0, 82.0], "imaging-darkroom": [148.0, 155.0, 155.0, 155.0, 155.0, 155.0, 154.0, 163.0, 155.0, 154.0], "stanford-crypto-ccm": [160.0, 158.0, 161.0, 151.0, 160.0, 153.0, 157.0, 156.0, 153.0, 151.0], "audio-oscillator": [120.0, 116.0, 167.0, 109.0, 109.0, 112.0, 162.0, 114.0, 112.0, 158.0], "stanford-crypto-aes": [97.0, 105.0, 106.0, 105.0, 109.0, 110.0, 110.0, 105.0, 105.0, 106.0], "imaging-desaturate": [111.0, 126.0, 121.0, 120.0, 114.0, 124.0, 114.0, 130.0, 119.0, 124.0]}, "summary": {"lowerIsBetter": true, "suite": 1848.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 100.5, "unit": "ms", "value": 100.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 186.2, "unit": "ms", "value": 186.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 179.8, "unit": "ms", "value": 179.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 156.0, "unit": "ms", "value": 156.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.9, "unit": "ms", "value": 154.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.6, "unit": "ms", "value": 72.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 127.9, "unit": "ms", "value": 127.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 133.4, "unit": "ms", "value": 133.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 196.4, "unit": "ms", "value": 196.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 84.9, "unit": "ms", "value": 84.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 143.9, "unit": "ms", "value": 143.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.8, "unit": "ms", "value": 105.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 120.3, "unit": "ms", "value": 120.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447581505, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115004216", "branch": "Mozilla-Inbound", "revision": "694f70dd36857b0c504b3feddf7538fb94797654"}}, {"talos_counters": {}, "results": {"DeltaBlue": [235.23876734885908], "Encrypt": [387.74718883288097], "NavierStokes": [7063.380281690141], "Decrypt": [6924.137931034483], "Splay": [819.000819000819], "Richards": [202.26537216828478], "RegExp": [36392.857142857145], "Earley": [976.5625], "Boyer": [15781.25], "RayTrace": [2383.3333333333335]}, "summary": {"lowerIsBetter": false, "suite": 15154.722782268067, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 281.0676179999999, "unit": "score", "value": 281.0676179999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 686.4807989999998, "unit": "score", "value": 686.4807989999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 210.0977068793618, "unit": "score", "value": 210.0977068793618}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.4424750996016, "unit": "score", "value": 38.4424750996016}, "Splay": {"lowerIsBetter": false, "filtered": 99.50051099999996, "unit": "score", "value": 99.50051099999996}, "RegExp": {"lowerIsBetter": false, "filtered": 25.03197252208046, "unit": "score", "value": 25.03197252208046}, "Richards": {"lowerIsBetter": false, "filtered": 174.53308799999994, "unit": "score", "value": 174.53308799999994}, "Earley": {"lowerIsBetter": false, "filtered": 682.458112, "unit": "score", "value": 682.458112}, "Boyer": {"lowerIsBetter": false, "filtered": 42.23131881188118, "unit": "score", "value": 42.23131881188118}, "RayTrace": {"lowerIsBetter": false, "filtered": 310.484895104895, "unit": "score", "value": 310.484895104895}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447581505, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115004216", "branch": "Mozilla-Inbound", "revision": "694f70dd36857b0c504b3feddf7538fb94797654"}}] 02:18:46 INFO - RETURN: dromaeo_css: 5487.10 02:18:46 INFO - RETURN: kraken: 1848.00 02:18:46 INFO - RETURN: v8_7: 15154.72 02:18:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15154.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1848.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5487.10"}}} 02:18:46 INFO - Return code: 0 02:18:46 INFO - # TBPL SUCCESS # 02:18:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:18:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:18:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:18:46 INFO - 2015-11-15 02:18:46.331 screenresolution[1666:10732] starting screenresolution argv=screenresolution get 02:18:46 INFO - 2015-11-15 02:18:46.335 screenresolution[1666:10732] Display 0: 1600x1200x32@60 02:18:46 INFO - 2015-11-15 02:18:46.341 screenresolution[1667:10735] starting screenresolution argv=screenresolution list 02:18:46 INFO - Available Modes on Display 0 02:18:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:18:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:18:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:18:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:18:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:18:46 INFO - Intel HD Graphics 3000: 02:18:46 INFO - Chipset Model: Intel HD Graphics 3000 02:18:46 INFO - Type: GPU 02:18:46 INFO - Bus: Built-In 02:18:46 INFO - VRAM (Total): 512 MB 02:18:46 INFO - VRAM (Dynamic, Max): 10 02:18:46 INFO - Vendor: Intel (0x8086) 02:18:46 INFO - Device ID: 0x0116 02:18:46 INFO - Revision ID: 0x0009 02:18:46 INFO - Displays: 02:18:46 INFO - Display: 02:18:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:18:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:18:46 INFO - Display Serial Number: 1600x1200 60 02:18:46 INFO - Main Display: Yes 02:18:46 INFO - Mirror: Off 02:18:46 INFO - Online: Yes 02:18:46 INFO - Rotation: Supported 02:18:46 INFO - Return code: 0 02:18:46 INFO - Running post-action listener: _resource_record_post_action 02:18:46 INFO - Running post-run listener: _resource_record_post_run 02:18:47 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 40772608; Write bytes: 687521792; Read time: 4805; Write time: 50769 02:18:47 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 338784768; Write bytes: 334352384; Read time: 37951; Write time: 3861 02:18:47 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 39048192; Write bytes: 341962752; Read time: 4376; Write time: 46512 02:18:47 INFO - Running post-run listener: _upload_blobber_files 02:18:47 INFO - Blob upload gear active. 02:18:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:18:47 INFO - Copying logs to upload dir... 02:18:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1339.883125 ========= master_lag: 7.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-15 02:18:55.451467) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:18:55.452860) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/_jZuMnH5R2yJlQESKDqqOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.39 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 02:18:55.854809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2015-11-15 02:18:55.861581) ========= 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.CByXrlXxFt/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.DsnWamZhex/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005628 ========= master_lag: 8.82 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2015-11-15 02:19:04.682403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 02:19:04.682804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 02:19:04.817710) ========= ========= Total master_lag: 17.55 =========