builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0025 starttime: 1447813987.49 results: success (0) buildid: 20151117175137 builduid: 572b82ceffb74a57abcfee3670b0e81c revision: e85794f108f04dd2ee460c6b3e030a148185e81c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.492705) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.493110) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.493780) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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.006089 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.517026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.517418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.533382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.533655) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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.005577 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.697513) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.697826) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.698394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.698680) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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-17 18:33:07-- 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% 7.54M=0.002s 2015-11-17 18:33:07 (7.54 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.242370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.956707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:07.957013) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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.020125 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.006510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.006886) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e85794f108f04dd2ee460c6b3e030a148185e81c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e85794f108f04dd2ee460c6b3e030a148185e81c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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-17 18:33:08,076 truncating revision to first 12 chars 2015-11-17 18:33:08,076 Setting DEBUG logging. 2015-11-17 18:33:08,076 attempt 1/10 2015-11-17 18:33:08,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e85794f108f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:33:08,335 unpacking tar archive at: fx-team-e85794f108f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.562224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.562564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.575665) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.576025) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:33:08.576466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-17 18:33:08.576749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:08 INFO - MultiFileLogger online at 20151117 18:33:08 in /builds/slave/test 18:33:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:33:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:33:08 INFO - {'append_to_log': False, 18:33:08 INFO - 'base_work_dir': '/builds/slave/test', 18:33:08 INFO - 'blob_upload_branch': 'Fx-Team', 18:33:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:33:08 INFO - 'branch': 'Fx-Team', 18:33:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:33:08 INFO - 'config_files': ('talos/mac_config.py',), 18:33:08 INFO - 'default_actions': ('clobber', 18:33:08 INFO - 'read-buildbot-config', 18:33:08 INFO - 'download-and-extract', 18:33:08 INFO - 'populate-webroot', 18:33:08 INFO - 'create-virtualenv', 18:33:08 INFO - 'install', 18:33:08 INFO - 'run-tests'), 18:33:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:33:08 INFO - 'download_minidump_stackwalk': True, 18:33:08 INFO - 'download_symbols': 'ondemand', 18:33:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:33:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:33:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:33:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:33:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:33:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:33:08 INFO - 'installer_path': 'installer.exe', 18:33:08 INFO - 'log_level': 'info', 18:33:08 INFO - 'log_name': 'talos', 18:33:08 INFO - 'log_to_console': True, 18:33:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:33:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:33:08 INFO - 'opt_config_files': (), 18:33:08 INFO - 'pip_index': False, 18:33:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:08 INFO - 'cmd': ('bash', 18:33:08 INFO - '-c', 18:33:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:08 INFO - 'enabled': True, 18:33:08 INFO - 'halt_on_failure': False, 18:33:08 INFO - 'name': 'check_screen_resolution'},), 18:33:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:08 INFO - 'cmd': ('bash', 18:33:08 INFO - '-c', 18:33:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:08 INFO - 'enabled': True, 18:33:08 INFO - 'halt_on_failure': False, 18:33:08 INFO - 'name': 'check_screen_resolution'},), 18:33:08 INFO - 'run_cmd_checks_enabled': True, 18:33:08 INFO - 'sps_profile': False, 18:33:08 INFO - 'sps_profile_interval': 0, 18:33:08 INFO - 'suite': 'dromaeojs', 18:33:08 INFO - 'system_bits': '64', 18:33:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:33:08 INFO - 'title': 't-yosemite-r5-0025', 18:33:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:33:08 INFO - 'use_talos_json': True, 18:33:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:33:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:33:08 INFO - 'work_dir': 'build'} 18:33:08 INFO - ##### 18:33:08 INFO - ##### Running clobber step. 18:33:08 INFO - ##### 18:33:08 INFO - Running pre-action listener: _resource_record_pre_action 18:33:08 INFO - Running main action method: clobber 18:33:08 INFO - rmtree: /builds/slave/test/build 18:33:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:33:10 INFO - Running post-action listener: _resource_record_post_action 18:33:10 INFO - ##### 18:33:10 INFO - ##### Running read-buildbot-config step. 18:33:10 INFO - ##### 18:33:10 INFO - Running pre-action listener: _resource_record_pre_action 18:33:10 INFO - Running main action method: read_buildbot_config 18:33:10 INFO - Using buildbot properties: 18:33:10 INFO - { 18:33:10 INFO - "properties": { 18:33:10 INFO - "buildnumber": 1247, 18:33:10 INFO - "product": "firefox", 18:33:10 INFO - "script_repo_revision": "production", 18:33:10 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 18:33:10 INFO - "repository": "", 18:33:10 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 18:33:10 INFO - "buildid": "20151117175137", 18:33:10 INFO - "slavename": "t-yosemite-r5-0025", 18:33:10 INFO - "pgo_build": "False", 18:33:10 INFO - "basedir": "/builds/slave/test", 18:33:10 INFO - "project": "", 18:33:10 INFO - "platform": "yosemite", 18:33:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:33:10 INFO - "slavebuilddir": "test", 18:33:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:33:10 INFO - "branch": "fx-team", 18:33:10 INFO - "repo_path": "integration/fx-team", 18:33:10 INFO - "stage_platform": "macosx64", 18:33:10 INFO - "builduid": "572b82ceffb74a57abcfee3670b0e81c", 18:33:10 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:33:10 INFO - }, 18:33:10 INFO - "sourcestamp": { 18:33:10 INFO - "repository": "", 18:33:10 INFO - "hasPatch": false, 18:33:10 INFO - "project": "", 18:33:10 INFO - "branch": "fx-team-macosx64-talos", 18:33:10 INFO - "changes": [ 18:33:10 INFO - { 18:33:10 INFO - "category": null, 18:33:10 INFO - "files": [ 18:33:10 INFO - { 18:33:10 INFO - "url": null, 18:33:10 INFO - "name": "https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:33:10 INFO - } 18:33:10 INFO - ], 18:33:10 INFO - "repository": "", 18:33:10 INFO - "rev": "e85794f108f04dd2ee460c6b3e030a148185e81c", 18:33:10 INFO - "who": "mhammond@skippinet.com.au", 18:33:10 INFO - "when": 1447813939, 18:33:10 INFO - "number": 6675469, 18:33:10 INFO - "comments": "Bug 1221906 - Allow Sync to only sync specified engines. r=rnewman", 18:33:10 INFO - "project": "", 18:33:10 INFO - "at": "Tue 17 Nov 2015 18:32:19", 18:33:10 INFO - "branch": "fx-team-macosx64-talos", 18:33:10 INFO - "revlink": "", 18:33:10 INFO - "properties": [ 18:33:10 INFO - [ 18:33:10 INFO - "buildid", 18:33:10 INFO - "20151117175137", 18:33:10 INFO - "Change" 18:33:10 INFO - ], 18:33:10 INFO - [ 18:33:10 INFO - "builduid", 18:33:10 INFO - "572b82ceffb74a57abcfee3670b0e81c", 18:33:10 INFO - "Change" 18:33:10 INFO - ], 18:33:10 INFO - [ 18:33:10 INFO - "pgo_build", 18:33:10 INFO - "False", 18:33:10 INFO - "Change" 18:33:10 INFO - ] 18:33:10 INFO - ], 18:33:10 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:33:10 INFO - } 18:33:10 INFO - ], 18:33:10 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:33:10 INFO - } 18:33:10 INFO - } 18:33:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:33:10 INFO - Running post-action listener: _resource_record_post_action 18:33:10 INFO - ##### 18:33:10 INFO - ##### Running download-and-extract step. 18:33:10 INFO - ##### 18:33:10 INFO - Running pre-action listener: _resource_record_pre_action 18:33:10 INFO - Running main action method: download_and_extract 18:33:10 INFO - mkdir: /builds/slave/test/build/tests 18:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:10 INFO - https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:33:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/test_packages.json 18:33:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/test_packages.json 18:33:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:33:12 INFO - Downloaded 1149 bytes. 18:33:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:33:12 INFO - Using the following test package requirements: 18:33:12 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:33:12 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:33:12 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'jsshell-mac.zip'], 18:33:12 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:33:12 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:33:12 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:33:12 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:33:12 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:33:12 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:33:12 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:33:12 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:33:12 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:33: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')]} 18:33:12 INFO - https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:33:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:13 INFO - Downloaded 17463512 bytes. 18:33:13 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 18:33:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:33:19 INFO - Return code: 0 18:33:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:33: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')]} 18:33:19 INFO - https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:33:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:22 INFO - Downloaded 17463512 bytes. 18:33:22 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 18:33:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:33:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:33:28 INFO - Return code: 0 18:33: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')]} 18:33:28 INFO - https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:29 INFO - Downloaded 11131693 bytes. 18:33:29 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 18:33:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:33:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:33:30 INFO - Return code: 0 18:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:30 INFO - https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mmkKbZf-TimXm_kalOOZoA/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 18:33:34 INFO - Downloaded 108841506 bytes. 18:33:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:33:34 INFO - mkdir: /builds/slave/test/properties 18:33:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:34 INFO - Contents: 18:33:34 INFO - build_url:https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:33:34 INFO - Running post-action listener: _resource_record_post_action 18:33:34 INFO - Running post-action listener: set_extra_try_arguments 18:33:34 INFO - ##### 18:33:34 INFO - ##### Running populate-webroot step. 18:33:34 INFO - ##### 18:33:34 INFO - Running pre-action listener: _resource_record_pre_action 18:33:34 INFO - Running main action method: populate_webroot 18:33:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:33:34 INFO - '../fennec_ids.txt'], 18:33:34 INFO - 'tests': ['tcheck2']}, 18:33:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:34 INFO - '--tppagecycles', 18:33:34 INFO - '7'], 18:33:34 INFO - 'tests': ['tsvgm']}}, 18:33:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:33:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:33:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:33:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'tests': ['damp', 'tps']}, 18:33:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['damp', 'tps']}, 18:33:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:33:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:34 INFO - 'other': {'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'other_l64': {'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'other_nol64': {'tests': ['a11yr', 18:33:34 INFO - 'ts_paint', 18:33:34 INFO - 'tpaint', 18:33:34 INFO - 'sessionrestore', 18:33:34 INFO - 'sessionrestore_no_auto_restore']}, 18:33:34 INFO - 'svgr': {'tests': ['tsvgx', 18:33:34 INFO - 'tsvgr_opacity', 18:33:34 INFO - 'tart', 18:33:34 INFO - 'tscrollx', 18:33:34 INFO - 'cart']}, 18:33:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['tsvgx', 18:33:34 INFO - 'tsvgr_opacity', 18:33:34 INFO - 'tart', 18:33:34 INFO - 'tscrollx', 18:33:34 INFO - 'cart']}, 18:33:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'tests': ['tp5o']}, 18:33:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'talos_options': ['--e10s'], 18:33:34 INFO - 'tests': ['tp5o']}, 18:33:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'talos_options': ['--xperf_path', 18:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:34 INFO - 'tests': ['tp5n']}, 18:33:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:34 INFO - 'talos_options': ['--e10s', 18:33:34 INFO - '--xperf_path', 18:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:34 INFO - 'tests': ['tp5n']}}, 18:33:34 INFO - 'talos.zip': {'path': '', 18:33:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:34 INFO - Running post-action listener: _resource_record_post_action 18:33:34 INFO - ##### 18:33:34 INFO - ##### Running create-virtualenv step. 18:33:34 INFO - ##### 18:33:34 INFO - Running pre-action listener: _resource_record_pre_action 18:33:34 INFO - Running main action method: create_virtualenv 18:33:34 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:34 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 18:33:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:34 INFO - Using real prefix '/tools/python27' 18:33:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:38 INFO - Installing pip.................done. 18:33:38 INFO - Return code: 0 18:33:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:38 INFO - 'HOME': '/Users/cltbld', 18:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:38 INFO - 'LOGNAME': 'cltbld', 18:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:38 INFO - 'MOZ_NO_REMOTE': '1', 18:33:38 INFO - 'NO_EM_RESTART': '1', 18:33:38 INFO - 'PAGER': '/bin/cat', 18:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:38 INFO - 'PWD': '/builds/slave/test', 18:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:38 INFO - 'SHELL': '/bin/bash', 18:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:38 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:38 INFO - 'USER': 'cltbld', 18:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:38 INFO - 'XPC_FLAGS': '0x0', 18:33:38 INFO - 'XPC_SERVICE_NAME': '0', 18:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:33:39 INFO - Cleaning up... 18:33:39 INFO - Return code: 0 18:33:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:39 INFO - 'HOME': '/Users/cltbld', 18:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:39 INFO - 'LOGNAME': 'cltbld', 18:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:39 INFO - 'MOZ_NO_REMOTE': '1', 18:33:39 INFO - 'NO_EM_RESTART': '1', 18:33:39 INFO - 'PAGER': '/bin/cat', 18:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:39 INFO - 'PWD': '/builds/slave/test', 18:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:39 INFO - 'SHELL': '/bin/bash', 18:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:39 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:39 INFO - 'USER': 'cltbld', 18:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:39 INFO - 'XPC_FLAGS': '0x0', 18:33:39 INFO - 'XPC_SERVICE_NAME': '0', 18:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:39 INFO - Downloading/unpacking psutil>=0.7.1 18:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:33:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:41 INFO - Installing collected packages: psutil 18:33:41 INFO - Running setup.py install for psutil 18:33:42 INFO - building 'psutil._psutil_osx' extension 18:33:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:33:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:33:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:33:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:33:42 INFO - building 'psutil._psutil_posix' extension 18:33:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:33:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:42 INFO - ^ 18:33:42 INFO - 1 warning generated. 18:33:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:42 INFO - Successfully installed psutil 18:33:42 INFO - Cleaning up... 18:33:42 INFO - Return code: 0 18:33:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:42 INFO - 'HOME': '/Users/cltbld', 18:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:42 INFO - 'LOGNAME': 'cltbld', 18:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:42 INFO - 'MOZ_NO_REMOTE': '1', 18:33:42 INFO - 'NO_EM_RESTART': '1', 18:33:42 INFO - 'PAGER': '/bin/cat', 18:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:42 INFO - 'PWD': '/builds/slave/test', 18:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:42 INFO - 'SHELL': '/bin/bash', 18:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:42 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:42 INFO - 'USER': 'cltbld', 18:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:42 INFO - 'XPC_FLAGS': '0x0', 18:33:42 INFO - 'XPC_SERVICE_NAME': '0', 18:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:33:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:33:45 INFO - Installing collected packages: mozsystemmonitor 18:33:45 INFO - Running setup.py install for mozsystemmonitor 18:33:45 INFO - Successfully installed mozsystemmonitor 18:33:45 INFO - Cleaning up... 18:33:45 INFO - Return code: 0 18:33:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:45 INFO - 'HOME': '/Users/cltbld', 18:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:45 INFO - 'LOGNAME': 'cltbld', 18:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:45 INFO - 'MOZ_NO_REMOTE': '1', 18:33:45 INFO - 'NO_EM_RESTART': '1', 18:33:45 INFO - 'PAGER': '/bin/cat', 18:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:45 INFO - 'PWD': '/builds/slave/test', 18:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:45 INFO - 'SHELL': '/bin/bash', 18:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:45 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:45 INFO - 'USER': 'cltbld', 18:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:45 INFO - 'XPC_FLAGS': '0x0', 18:33:45 INFO - 'XPC_SERVICE_NAME': '0', 18:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:49 INFO - Downloading docopt-0.6.1.tar.gz 18:33:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:49 INFO - Running setup.py install for blobuploader 18:33:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:50 INFO - Running setup.py install for requests 18:33:50 INFO - Running setup.py install for docopt 18:33:50 INFO - Successfully installed blobuploader requests docopt 18:33:50 INFO - Cleaning up... 18:33:50 INFO - Return code: 0 18:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:50 INFO - 'HOME': '/Users/cltbld', 18:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:50 INFO - 'LOGNAME': 'cltbld', 18:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:50 INFO - 'MOZ_NO_REMOTE': '1', 18:33:50 INFO - 'NO_EM_RESTART': '1', 18:33:50 INFO - 'PAGER': '/bin/cat', 18:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:50 INFO - 'PWD': '/builds/slave/test', 18:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:50 INFO - 'SHELL': '/bin/bash', 18:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:50 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:50 INFO - 'USER': 'cltbld', 18:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:50 INFO - 'XPC_FLAGS': '0x0', 18:33:50 INFO - 'XPC_SERVICE_NAME': '0', 18:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-3EhbLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-ZB0n6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-yupIoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-Ygmu5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-ZPkYJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-eV9QJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:51 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-7rV3WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-LmyltF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-iyDOrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-FPKK2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-dlIozy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-GRWgrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-gbLBFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-Gndqi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:52 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-NN6oKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:53 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-OlHVjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:53 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-nq3OlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:53 INFO - Running setup.py install for manifestparser 18:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:53 INFO - Running setup.py install for mozcrash 18:33:53 INFO - Running setup.py install for mozdebug 18:33:53 INFO - Running setup.py install for mozdevice 18:33:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Running setup.py install for mozfile 18:33:54 INFO - Running setup.py install for mozhttpd 18:33:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Running setup.py install for mozinfo 18:33:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Running setup.py install for mozInstall 18:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:54 INFO - Running setup.py install for mozleak 18:33:54 INFO - Running setup.py install for mozlog 18:33:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Running setup.py install for moznetwork 18:33:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Running setup.py install for mozprocess 18:33:55 INFO - Running setup.py install for mozprofile 18:33:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Running setup.py install for mozrunner 18:33:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:55 INFO - Running setup.py install for mozscreenshot 18:33:55 INFO - Running setup.py install for moztest 18:33:56 INFO - Running setup.py install for mozversion 18:33:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:56 INFO - Cleaning up... 18:33:56 INFO - Return code: 0 18:33:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:56 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')]} 18:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:56 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')]} 18:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:56 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 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:33:56 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 18:33:56 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 18:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:56 INFO - 'HOME': '/Users/cltbld', 18:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:56 INFO - 'LOGNAME': 'cltbld', 18:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:56 INFO - 'MOZ_NO_REMOTE': '1', 18:33:56 INFO - 'NO_EM_RESTART': '1', 18:33:56 INFO - 'PAGER': '/bin/cat', 18:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:56 INFO - 'PWD': '/builds/slave/test', 18:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:56 INFO - 'SHELL': '/bin/bash', 18:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:33:56 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:56 INFO - 'USER': 'cltbld', 18:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:56 INFO - 'XPC_FLAGS': '0x0', 18:33:56 INFO - 'XPC_SERVICE_NAME': '0', 18:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:56 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-A2KGlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:56 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)) 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:56 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-w67uGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:56 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)) 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:56 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-5jEQQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:56 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)) 18:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:56 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-qpZr9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-2zV4p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-taO5Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-Fn3LoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-bNfg15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-D7CGsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-NKkVxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-K1oOZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:57 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)) 18:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:57 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-AaBDSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:58 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)) 18:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:58 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-HDaem2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:58 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)) 18:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:58 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-Zs4Qyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:58 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)) 18:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:58 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-bDKdTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:58 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)) 18:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:58 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-gOAyqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:58 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)) 18:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:58 INFO - Running setup.py (path:/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/pip-SnryJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:58 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)) 18:33:58 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)) 18:33:58 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)) 18:33:58 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)) 18:33:58 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)) 18:33:58 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)) 18:33:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:34:01 INFO - Downloading blessings-1.5.1.tar.gz 18:34:01 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 18:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:01 INFO - Installing collected packages: blessings 18:34:01 INFO - Running setup.py install for blessings 18:34:01 INFO - Successfully installed blessings 18:34:01 INFO - Cleaning up... 18:34:01 INFO - Return code: 0 18:34:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:34:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:01 INFO - Reading from file tmpfile_stdout 18:34:01 INFO - Current package versions: 18:34:01 INFO - blessings == 1.5.1 18:34:01 INFO - blobuploader == 1.2.4 18:34:01 INFO - docopt == 0.6.1 18:34:01 INFO - manifestparser == 1.1 18:34:01 INFO - mozInstall == 1.12 18:34:01 INFO - mozcrash == 0.16 18:34:01 INFO - mozdebug == 0.1 18:34:01 INFO - mozdevice == 0.47 18:34:01 INFO - mozfile == 1.2 18:34:01 INFO - mozhttpd == 0.7 18:34:01 INFO - mozinfo == 0.9 18:34:01 INFO - mozleak == 0.1 18:34:01 INFO - mozlog == 3.0 18:34:01 INFO - moznetwork == 0.27 18:34:01 INFO - mozprocess == 0.22 18:34:01 INFO - mozprofile == 0.27 18:34:01 INFO - mozrunner == 6.11 18:34:01 INFO - mozscreenshot == 0.1 18:34:01 INFO - mozsystemmonitor == 0.0 18:34:01 INFO - moztest == 0.7 18:34:01 INFO - mozversion == 1.4 18:34:01 INFO - psutil == 3.1.1 18:34:01 INFO - requests == 1.2.3 18:34:01 INFO - wsgiref == 0.1.2 18:34:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:01 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 0x108061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa043567cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, '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.p18YyrQYQW/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.rZdrys72m3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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 18:34:01 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 18:34:01 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 18:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:01 INFO - 'HOME': '/Users/cltbld', 18:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:01 INFO - 'LOGNAME': 'cltbld', 18:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:01 INFO - 'MOZ_NO_REMOTE': '1', 18:34:01 INFO - 'NO_EM_RESTART': '1', 18:34:01 INFO - 'PAGER': '/bin/cat', 18:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:01 INFO - 'PWD': '/builds/slave/test', 18:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:01 INFO - 'SHELL': '/bin/bash', 18:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:34:01 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:01 INFO - 'USER': 'cltbld', 18:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:01 INFO - 'XPC_FLAGS': '0x0', 18:34:01 INFO - 'XPC_SERVICE_NAME': '0', 18:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 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)) 18:34:02 INFO - Cleaning up... 18:34:02 INFO - Return code: 0 18:34:02 INFO - Running post-action listener: _resource_record_post_action 18:34:02 INFO - Running post-action listener: _start_resource_monitoring 18:34:02 INFO - Starting resource monitoring. 18:34:02 INFO - ##### 18:34:02 INFO - ##### Running install step. 18:34:02 INFO - ##### 18:34:02 INFO - Running pre-action listener: _resource_record_pre_action 18:34:02 INFO - Running main action method: install 18:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:02 INFO - Reading from file tmpfile_stdout 18:34:02 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:34:02 INFO - Reading from file tmpfile_stdout 18:34:02 INFO - Output received: 18:34:02 INFO - Usage: mozinstall [options] installer 18:34:02 INFO - Options: 18:34:02 INFO - -h, --help show this help message and exit 18:34:02 INFO - -d DEST, --destination=DEST 18:34:02 INFO - Directory to install application into. [default: 18:34:02 INFO - "/builds/slave/test"] 18:34:02 INFO - --app=APP Application being installed. [default: firefox] 18:34:02 INFO - mkdir: /builds/slave/test/build/application 18:34:02 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'] 18:34:02 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 18:34:41 INFO - Reading from file tmpfile_stdout 18:34:41 INFO - Output received: 18:34:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:41 INFO - Running post-action listener: _resource_record_post_action 18:34:41 INFO - ##### 18:34:41 INFO - ##### Running run-tests step. 18:34:41 INFO - ##### 18:34:41 INFO - Running pre-action listener: _resource_record_pre_action 18:34:41 INFO - Running main action method: run_tests 18:34:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:41 INFO - 2015-11-17 18:34:41.630 screenresolution[1921:11539] starting screenresolution argv=screenresolution get 18:34:41 INFO - 2015-11-17 18:34:41.634 screenresolution[1921:11539] Display 0: 1600x1200x32@60 18:34:41 INFO - 2015-11-17 18:34:41.641 screenresolution[1922:11541] starting screenresolution argv=screenresolution list 18:34:41 INFO - Available Modes on Display 0 18:34:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:41 INFO - Intel HD Graphics 3000: 18:34:41 INFO - Chipset Model: Intel HD Graphics 3000 18:34:41 INFO - Type: GPU 18:34:41 INFO - Bus: Built-In 18:34:41 INFO - VRAM (Total): 512 MB 18:34:41 INFO - VRAM (Dynamic, Max): 10 18:34:41 INFO - Vendor: Intel (0x8086) 18:34:41 INFO - Device ID: 0x0116 18:34:41 INFO - Revision ID: 0x0009 18:34:41 INFO - Displays: 18:34:41 INFO - Display: 18:34:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:41 INFO - Display Serial Number: 1600x1200 60 18:34:41 INFO - Main Display: Yes 18:34:41 INFO - Mirror: Off 18:34:41 INFO - Online: Yes 18:34:41 INFO - Rotation: Supported 18:34:41 INFO - Return code: 0 18:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:41 INFO - Python 2.7.3 18:34:41 INFO - Return code: 0 18:34:41 INFO - grabbing minidump binary from tooltool 18:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:41 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 0x107f849f0>, '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 0x107ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f788c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:41 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 18:34:41 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 18:34:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:42 INFO - Return code: 0 18:34:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0025', '--webServer', 'localhost'] in /builds/slave/test/build 18:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0025 --webServer localhost 18:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p18YyrQYQW/Render', 18:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:42 INFO - 'HOME': '/Users/cltbld', 18:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:42 INFO - 'LOGNAME': 'cltbld', 18:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:42 INFO - 'MOZ_NO_REMOTE': '1', 18:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:42 INFO - 'NO_EM_RESTART': '1', 18:34:42 INFO - 'PAGER': '/bin/cat', 18:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:42 INFO - 'PWD': '/builds/slave/test', 18:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:42 INFO - 'SHELL': '/bin/bash', 18:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZdrys72m3/Listeners', 18:34:42 INFO - 'TMPDIR': '/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/', 18:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:42 INFO - 'USER': 'cltbld', 18:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:42 INFO - 'XPC_FLAGS': '0x0', 18:34:42 INFO - 'XPC_SERVICE_NAME': '0', 18:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:34:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0025', '--webServer', 'localhost'] with output_timeout 3600 18:34:42 INFO - mozversion INFO | application_buildid: 20151117175137 18:34:42 INFO - mozversion INFO | application_changeset: e85794f108f04dd2ee460c6b3e030a148185e81c 18:34:42 INFO - mozversion INFO | application_display_name: Nightly 18:34:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:42 INFO - mozversion INFO | application_name: Firefox 18:34:42 INFO - mozversion INFO | application_remotingname: firefox 18:34:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:34:42 INFO - mozversion INFO | application_vendor: Mozilla 18:34:42 INFO - mozversion INFO | application_version: 45.0a1 18:34:42 INFO - mozversion INFO | platform_buildid: 20151117175137 18:34:42 INFO - mozversion INFO | platform_changeset: e85794f108f04dd2ee460c6b3e030a148185e81c 18:34:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:34:42 INFO - mozversion INFO | platform_version: 45.0a1 18:34:42 INFO - 2015-11-17 18:34:42,279 DEBUG : using testdate: 1447814082 18:34:42 INFO - 2015-11-17 18:34:42,279 DEBUG : actual date: 1447814082 18:34:42 INFO - 2015-11-17 18:34:42,288 INFO : starting webserver on 'localhost:49657' 18:34:42 INFO - 2015-11-17 18:34:42,290 INFO : Starting test suite t-yosemite-r5-0025 18:34:42 INFO - 2015-11-17 18:34:42,290 INFO : Starting test dromaeo_css 18:34:42 INFO - 2015-11-17 18:34:42,290 DEBUG : operating with platform_type : mac_ 18:34:42 INFO - 2015-11-17 18:34:42,291 INFO : Initialising browser for dromaeo_css test... 18:34:42 INFO - 2015-11-17 18:34:42,305 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmppoqUUf/profile http://localhost:49657/getInfo.html 18:34:44 INFO - 2015-11-17 18:34:44,900 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:34:44 INFO - 2015-11-17 18:34:44,900 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:34:44 INFO - 2015-11-17 18:34:44,900 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:34:44 INFO - 2015-11-17 18:34:44,901 DEBUG : BROWSER_OUTPUT: __metrics 18:34:44 INFO - 2015-11-17 18:34:44,937 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:45 INFO - 2015-11-17 18:34:45,780 INFO : Browser initialized. 18:34:45 INFO - 2015-11-17 18:34:45,780 INFO : Running cycle 1/1 for dromaeo_css test... 18:34:45 INFO - 2015-11-17 18:34:45,780 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmppoqUUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:34:57 INFO - 2015-11-17 18:34:57,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 250421248 18:34:57 INFO - 2015-11-17 18:34:57,847 DEBUG : BROWSER_OUTPUT: 18:35:49 INFO - 2015-11-17 18:35:49,467 DEBUG : BROWSER_OUTPUT: 1447814149463 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] 18:37:59 INFO - 2015-11-17 18:37:59,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49657/tests/dromaeo/cssquery-ext.html) 18:38:00 INFO - 2015-11-17 18:38:00,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 342962176 18:38:00 INFO - 2015-11-17 18:38:00,910 DEBUG : BROWSER_OUTPUT: 18:41:03 INFO - 2015-11-17 18:41:03,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-ext.html (next: http://localhost:49657/tests/dromaeo/cssquery-jquery.html) 18:41:04 INFO - 2015-11-17 18:41:04,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 365674496 18:41:04 INFO - 2015-11-17 18:41:04,295 DEBUG : BROWSER_OUTPUT: 18:44:06 INFO - 2015-11-17 18:44:06,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49657/tests/dromaeo/cssquery-mootools.html) 18:44:07 INFO - 2015-11-17 18:44:07,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 328421376 18:44:07 INFO - 2015-11-17 18:44:07,209 DEBUG : BROWSER_OUTPUT: 18:47:09 INFO - 2015-11-17 18:47:09,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49657/tests/dromaeo/cssquery-prototype.html) 18:47:09 INFO - 2015-11-17 18:47:09,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 327053312 18:47:09 INFO - 2015-11-17 18:47:09,964 DEBUG : BROWSER_OUTPUT: 18:50:13 INFO - 2015-11-17 18:50:13,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49657/tests/dromaeo/cssquery-yui.html) 18:50:13 INFO - 2015-11-17 18:50:13,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 329388032 18:50:13 INFO - 2015-11-17 18:50:13,715 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-yui.html (next: http://localhost:49657/tests/dromaeo/cssquery-dojo.html) 18:53:16 INFO - 2015-11-17 18:53:16,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 375762944 18:53:16 INFO - 2015-11-17 18:53:16,836 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,836 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:16 INFO - 2015-11-17 18:53:16,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:16 INFO - 2015-11-17 18:53:16,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:16 INFO - 2015-11-17 18:53:16,836 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:16 INFO - 2015-11-17 18:53:16,837 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2794.1617514745576;2824.08217329368;2839.6024556562083;2879.7264259895314;3081.5531747896553;4586.289125185602;4695.600873925712;4768.403949506312;4806.591439727623;4924.729139897308;4640.67515273931;4685.812567497304;4728.243481043034;4734.644901632374;4806.735629540374;4352.12957408518;4394.274944634131;4430.689851710382;4475.060237350161;4568.862934111982;4477.395551600524;4507.233770259048;4545.749983750892;4555.225611646011;4605.700629459091;4215.093754842724;4341.218580655481;4390.034192477649;4453.398791163184;4580.839670611513;4328.264195086811;4416.138852923681;4416.602505774464;4435.401220835211;4454.175977444151;4394.384786129945;4403.911921761547;4404.471463424377;4488.663350248712;4553.225951588238;4734.976325118352;4742.407199100113;4756.881077973044;4777.665563410563;4833.661643684944;4928.852134435972;5064.746762661852;5098.2352647103235;5122.436531981479;5160.174372100483;5014.448410674823;5067.543921047087;5087.745612719349;5121.052605268037;5152.433232344439;4741.525847415231;4817.470078291385;4839.733814640158;4859.416869975626;4922.950770492285;5077.593792496591;5134.409542902539;5157.355330583677;5188.11801993662;5295.046891559479;4883.95116048835;4979.601631869442;4986.301917731521;5016.949830501649;5124.538791508782;5080.390353157644;5083.61872859537;5085.542301192911;5126.92309615356;5127.359080114986;4827.2035114206465;5010.173321401928;5028.698278103252;5047.2429135629945;5115.002574498011;4955.281484184845;4970.15507363749;4971.1797553404;4986.351774269322;5016.874578135576;3851.2490064437166;3855.383138697795;3902.687784977195;3906.9609303906595;3918.059665680273;3532.2582257725653;3536.664016918389;3608.566971963381;3610.9638903610626;3650.452432135201;4739.146953548395;4811.639127065414;4812.879678008007;4814.518548145227;4868.732219727878;4876.195427754381;5067.5185857343495;5073.239014147834;5085.771140298695;5095.439501654815;4867.099586576494;4878.170710979142;4880.365552478226;4945.629077819178;4953.380827396575;4480.417545719036;4571.062932098912;4573.977130114328;4577.679562430598;4624.05206932578;5035.471275516018;5332.626716129834;5353.063213937623;5379.731013449312;5427.0773968425465;5069.239614057921;5096.413912400121;5151.7166555839785;5156.303898973591;5184.481551844785;5343.305370301836;5373.086575282289;5373.35519737634;5373.731313434235;5419.647722897999;4852.053849499313;5001.724905130252;5143.768530416065;5147.794088236428;5151.8196863109615;5101.9744901276745;5104.438511763778;5132.409772876018;5162.483751624958;5192.558632516128;5023.321851549994;5047.116754567863;5063.924041139459;5075.086484432837;5096.566791822736;4819.662623616313;4954.20732682769;5037.496250374933;5039.370078740158;5076.82231121909;4857.198562237191;4888.633352498648;4913.140200464976;4945.208766597327;4970.304157418037;5043.52086551777;5069.847904562869;5078.873028174326;5099.107656160231;5150;4990.900181996412;4995.225740010304;5012.223105418666;5053.216751403538;5114.284000239895 18:53:16 INFO - 2015-11-17 18:53:16,838 DEBUG : BROWSER_OUTPUT: |1;ext.html;500.5320025775899;502.18144424587916;506.55929341472927;515.7189331814161;532.8694469854886;27438.5884211737;28686.426271474586;34599.4810077849;34670.47994280088;35323.64676353236;37676.623233767656;37912.81043594778;37947.24105517895;38393;38430.423543646866;7311.415086793044;8274.503529788217;8324.417290789617;8401.95799021004;8523.977122745278;7484.02707648005;9890.653827116052;9939.40363578184;9990.15182191297;10027.498625068754;9778.217742580611;9852.95073524635;9860.30977831552;9972.451515166664;10000.749981250454;7614.505057171266;7772.611369431505;9694;9809.362391444569;9910.603575856992;9651.71044868655;9675;9787;9818.214542836557;9851.458169800659;34892.82553587216;35295;35434;35681.28637427237;35950.64049359499;2671.7595416412423;2740.7533322001113;2773.5285001549787;2861.1702606244166;3105.6894310568987;24122.39694007664;24262.757372426226;24890.253292401077;24978.250652480456;25115.12097076612;2063.2778527515397;2090.080364639554;2099.8740075595515;2107.2097963263777;2215.767344428828;222660;222917;223839;224350;227180;49413.25880111801;50864.745676271385;50934.74532627313;51489.22766158511;51533;47509;60813.391866080776;62463;62606;62664.37335626676;14478.420863165566;14592.343344549521;14793.92603036978;14796.112233266038;14817;10892.61875834342;10934.507947142398;11077.556897724162;11218.158638102175;11220.607278745369;17001.574960626083;17111.315547377966;17131.657366852593;17147.22837472292;17365.826341736672;7745.690172393154;7855.60721963911;7885.358404934296;7947.642356093989;7979.521228726295;871.8605023196258;892.3352102683542;935.7707361696428;960.5341409416427;1008.193445243802;24925.252242432754;25184.74815251824;25255.62116568253;25267.241982740547;25477.560529328675;933.4446004627235;950.5864948747317;1016.9796604067877;1026.1995643398013;1032.6282538286212;12998.415071321813;13024.47902083906;13237.669058273428;13249.205047696976;13373.732525349438;234838;241205;244246;244677;246286;48045.279320810216;48073.519264807604;48298.517014830104;48313;48465.75767121212;1251.3993283224104;1259.345140526939;1272.885440310358;1282.8139919711402;1283.0569531394417;24434.755652443248;25178.74821251764;25182.370440739127;25393.365165870262;25478.745212547637;39093.609063908996;43055.78472107745;43189.56810431981;43479.56520434755;43675;167371;322318;334851;335555;336844;28089.859550702116;28629.284267892635;28663.71336286694;28670.283242919093;28807.8559607209;35782;36238.275234494635;37007.259854802214;37085.44371834479;37198.44202337021;30532.08403747891;31306.373872522876;31466.685333147292;31528.36943261076;31746.396772468324;30321.24196895095;30929.536056959612;31473;33786;34346;31323.53014704827;31406.214844629067;31967.040988770375;32087.197820054684;32131.357372851944;26402;27725.168244952685;27815.582766258925;27956.30109247285;28126.85936570304;21440.571188576454;21466.570668586854;21565.24521641735;21675.783242168007;21680.67478987785 18:53:16 INFO - 2015-11-17 18:53:16,842 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.5109436222515;296.904990403071;307.6492798210041;308.9397567474343;312.46100476677725;12661.620151395473;12909.677258068554;14979.999999999987;14987.925060374697;15185.544433666993;10348.327358721677;10729.678109656703;10805.243632945698;13748.106373085768;15549.53351399457;3848.2111167210796;3858.151206734528;3875.8255878485393;3927.803609819512;3940.290747665419;3042.4675681755716;3130.3582765533124;3156.8421578921075;3752.8874133775894;3772.9434058489005;4140;4249.235137675218;4254.893627659318;4330.155619654169;4367.03925136471;4247.5540068293;4258.148370325916;4261.76560289184;4290.442242508485;4296.2696341621995;3545.911352216215;3559.7330200235087;3562.893113206582;3565.6434356564396;3609.981950090259;11376;11439.771204575945;11786;11793.823092653616;11796.115291353182;1648.2747591060015;1688.6285017296175;1735.774349334591;1764.7882254129586;1875.353003213889;8441.535715535643;8545.145485451467;8658.177473140042;8868.246199073023;8938.4190027648;1400.8459069502346;1412.8375236847792;1476.6677497563069;1506.3823832228734;1545.667681448494;50762;53479.732601337135;53539.19691204635;53952.73023634896;54229.1865622016;5785.190073389729;5860.706964651836;5936.198613187251;5949.345571987078;5967;6728.966355168192;6731.1922569292;6753.189617245962;6806.353396427331;6820.113385259884;4936;4967.950320496821;4982.626303027288;5009.373828271466;5009.7495125243595;5279.604029697788;5343.786248550092;5350.973245133828;5378.273933019071;5386.084365657769;2657.216121244199;2688.1263589333544;2712.4710681417328;2712.6609173853267;2713.0368719104436;941.0730430525927;943.5329511891521;949.8480243161061;954.7660823098386;984.7538115471132;340.66784884737183;345.9204382991926;347.47704704419687;357.9266250418658;358.26198032054054;8980.640774368952;9305.627774889064;9314.301427392973;9483.28875334339;9744.415335079917;323.6003535633491;368.1440650487627;373.23486851953385;381.28889620857456;383.4248627059411;4712.6229901607785;5117.692938423706;5124.666896651705;5141.562967147759;5226.268322434862;455620;466565;470385;474807;492894;63121.36878631155;64157.679211603645;64320;64325.35674643287;65089.349106509275;392.30170296871614;394.43004857979946;396.56377984217704;396.89482287193914;400.01396557485356;8823.602937867683;8864.157904999014;8904;9080.046595107682;9101.817963640558;30311.545326819672;30859.228519287197;31044.22389440282;31113.53329700011;31275.530867036556;41906.58093419149;42337.78831105825;42381.57618423776;43044.78477607592;43414.34878476762;6907.067545881242;6926.06498122747;7036.894446583407;7046.682899269443;7073.221945586084;10701.89298107009;10735.194860385345;10786.137109031102;10789.730256743644;10849.783004340026;9082.954585227031;9136.908630913871;9226.031266716898;9316.254699623878;9391.060893910555;7874;8189;8625.094365091574;8810.647574096964;8827.823443531222;8415.915840841513;8736.510094623001;8948;9053.909460905306;9181.586828592863;13601.659958501117;13824.516141934984;13964.30178491051;13973.580792576238;14257.215853128178;13165.802512962506;13755.587332380044;14044.508442204473;14144.151350918977;14167.36246868914 18:53:16 INFO - 2015-11-17 18:53:16,842 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1102.9283096598726;1172.677513683737;1202.8255902894075;1207.997362189383;1245.7383949370635;5600.747966341514;5727.856803579913;6337.619742815435;6542.738290468375;6633.867322653544;6442.871142577157;6452.128962590049;6457.967710161454;6483.870322593545;6507.967460162693;1707.2573430557686;1752.6144248265362;1948.3473036532778;1957.8140076692691;1967.7737060238112;1781.198460692687;1782.1623836796684;1791.578978939948;1800.97298540522;1908.8186622270932;1886.8584856135776;1889.6598612249788;1890.2816929566745;1890.395073576456;1907.7424547686023;1817.990910045448;1847.7136043913147;1905.9332923347754;1916.1090093106634;1933.2846846666682;1909.608530251309;1946.6496030714466;1961.9705704414446;1977.2189984956005;1982.5341044854447;6450.870982580369;6531.7387304507765;6536.954087346049;6540.2805691373915;6545.607263564201;4057.634812866856;4128.339465685506;4130.710850240484;4150.377443383486;4157.272477316457;2555.527227462925;2586.4697736963876;2622.2264431992608;2644.9603255951174;2695.2049145502124;820.4420993724265;822.4818364430371;826.5330088500039;849.5582297205481;853.4836423963475;8629.352798540072;8641.30869530436;8644.783880402978;8645.567721613894;8651.567421628893;3292.917677058045;3618.5115009473384;3669.7614655047337;3698.352788262097;3711.4989476420337;7075.716971321192;7340.082489688789;7581.241875812485;7583.014208152905;7655.732049378245;3944.1322908959983;4063.878083657495;4074.511058672919;4085.632293093636;4125;3629.8185090745355;3641.5083963664565;3648.562172539312;3651.7626354286886;3673.2469843682516;2906.5349544072847;2916.154315248554;2938.4270067337093;2958.127352431038;2988.44713727961;969.060011788564;991.8512223166583;993.1806259835664;996.531630133836;999.2006394884064;857.4298091769028;858.1547176031604;867.5922316511229;869.5956380283199;1097.5280629329304;6230.56386052981;6241.843953901189;6248.968755156195;6266.49868010558;6334.904976425358;571.5056476148102;592.523018969725;597.1192491075628;602.2171177469272;604.5888795618934;4969.925451118163;4992.400911890596;4995.25071239317;5069.822556210515;5095.133827249377;7571.848563028819;7615.923840761632;7620.3522700571075;7704.191059938737;7745.302922736981;7559.697612095454;7586.81032974169;7598.620068996528;7664.770056898302;7689.846203075907;5962.314333851576;6057.848553786191;6242.500599952084;6245.406686364788;6336.04959256106;6160.907586386118;6203.596766210362;6204.069389591597;6205.565610407409;6291.056341548804;6774.458043356618;6925.653717314215;6975;6982.965085174542;7024.438044956289;7117;7146.821329466805;7191;7193.892091618525;7210.315020073084;5357.973210133924;5507.072524616352;5701.914471283017;5791.594588378773;5853.799971005848;5913.201717768046;6063.242094738158;6180.072989051679;6262.1546091278915;6284.968575157095;5706.3152421709665;5791.710414479175;5918.644881307136;6014.278286605635;6050.0924861269405;5775.624584402;5825.563082768725;5923.733431995484;5928.851778705567;6007.12896629995;5870.207521984648;5885.352611212848;5933.584649074523;6024.638521688713;6038.124471951454;5491.148871924858;5493.395726470005;5505.944940550543;5518.944810551843;5566.526845218202;5562.554995600423;5574.136008918624;5576;5600.691961942132;5637.0135226334405 18:53:16 INFO - 2015-11-17 18:53:16,844 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.4244869242399;286.0545895814333;286.0816778142163;286.7476620573896;288.8570157771903;5452.809151679682;5471.3707923588745;5492.945070549298;5534.833954981347;5540.861478463041;5465.316835395575;5477.315335583052;5496.532794712454;5528.44715528447;5544.473275038875;4195.2029114468305;4203.054312779615;4214.093969796493;4215.725977811432;4223.915521689564;4075.3071977763702;4127.545969943304;4132.966758310423;4148.8133034013545;4205.285101532747;4138.730982486144;4160.105577300879;4171.332586786115;4214.97892510537;4220.493540775096;4143.19207754488;4159.604837540429;4187.350960601112;4205.537390887;4206.852760153411;3462.272922686239;3515.1212196950764;3548.520949671787;3565.6969157621634;3657.2319812839337;5273.6572122811895;5307.28351672527;5320.787168513255;5383.596230282745;5400.756965936543;4728.929066064012;4734.100520901018;4748.169070412664;4785.114753770564;4786.593139583139;5585.301837270341;5747.166660834156;5759.539236861041;5801.564882633819;5838.883222335529;3948.802559871995;3957.3866050762176;3974.1852920151587;3993.7803420811842;4004.659603933669;6057.394260573996;6069.848253793646;6124;6140.232470941132;6149.3235744068115;4023.3562629979647;4023.75857448554;4026.859059932888;4091.8977025574004;4092.1611069730634;4107.876763697094;4110.7328023678365;4116.115035267432;4125.29869922114;4139.441175441337;4059.65492933104;4543.295789152687;4564.88587785308;4681.274402467623;4781.760911954389;5769.740361683735;5788.942110578841;5830.533557315404;5867.735951882176;5867.794627188114;1430.3777856632398;1449.8840092792552;1454.4036944852771;1469.3461409672807;1471.3452513631546;948.8054948735493;964.8600952861796;970.6020531582018;979.8628192053118;982.017982017982;5538.44615538451;5567.526760225426;5584.609077364546;5621.128725047624;5621.915671264935;6013.248343957005;6033.668148251888;6071.726772295257;6089.086637004396;6124.5100391968535;5537.556995440355;5554.333479982428;5607.5513958884;5636.267285252973;5637.915431268534;3162.6679198683805;3241.6596257393107;3243.772935894465;3290.173953455855;3307.751918606114;6133.233345831771;6167.259928808482;6247.687615619201;6262.718177682015;6292.685365731695;6167.5682702210415;6221;6231.813045608639;6243.250809902841;6245;6036.577439579188;6143.354947730513;6187.783427579923;6203.534734894901;6220.564560480723;5989.071693887455;6063.272407311151;6091.5126789857595;6100.816975490565;6134.325224225421;5873.500752436091;5887.499562537232;5936.3470018297085;5951.494122999594;5962.19510366095;6165.815025549241;6181.690915454119;6235.282942461675;6238.500919926304;6280.434760871361;3922.941155882607;4000.4398284669583;4008.7995600219288;4014.799260037045;4049.0282332239462;5853.678047707247;6015.939840601538;6083.117947897618;6144.38556144382;6145.877082458415;5692.829215123553;5726;5847.970760146172;5942.078977758454;5951.018082016592;5813;5835.970820146042;5851.239338885917;5932.614380065282;5958.404159584007;5604.355499117653;5682.119271512922;5730;5779.306483222041;5796.884062318814;5840.883182336414;5857.26784151981;5869.73586188614;5885.705714714333;5930.584859059997;5745.396733343106;5807.912881306699;5824;5825.737841797214;5848 18:53:16 INFO - 2015-11-17 18:53:16,847 DEBUG : BROWSER_OUTPUT: |5;yui.html;653.6600967496905;672.1262358933388;686.1971493352777;688.1535711075377;698.853240819428;12232.694182645428;12425.254484730922;12458.314792686399;12627.810582841264;12660.936695316534;11082.335059896392;11527.884721152786;11645.18483706141;11652.82520762187;12735.108542402035;785.6582386661792;803.758872338299;804.1596531624466;810.4367464612097;814.8044469327349;768.1051574915217;801.5951944268137;802.3701394405393;802.7391097893179;809.9838003239931;835.7910522369408;844.160060739565;844.1727107434717;844.3751623798406;844.501743971057;815.7389635316702;830.3191383065888;832.0722394530115;833.1751565949667;833.2875391540236;613.7514306705791;616.4913945994573;623.7692053940026;624.0452108274347;625.0124802811592;11777.941110294394;11897.405129743478;11928.10539209554;11960.282383057045;12026.098042646836;9215.677451289239;9757.658481953098;10069.949650251701;10193.898061019368;10305.793884122351;7970.840583188304;8234.300084492825;8253.587320633944;8289.544075075868;8508.319334453228;2910.432465669195;2989.0584465893176;3026.092172348309;3038.6657467678538;3054.618172728409;36921.81539092314;37537.81231093827;39748.60251397478;41285.1742965139;41390;7407.148177959496;7623.618819059025;7645.350145237606;7648.694052237959;7871.724489642835;16163.676726465404;16179.676406471805;16265.83734162667;16339.346426143058;16377.754333685005;5422.783088676409;5422.945770542244;5585.497305242467;5967.671778052249;6168.629882207082;3513.894583162509;3580.2481478889204;3626.782393056425;3637.0725465006253;3660.633936606318;2631;2642.405458771799;2646.7485588869026;2654.4823759367123;2682.463507298548;379.9677027452698;408.3507223514626;419.4253872195051;424.9893752656146;428.282626600443;517.3809204613751;525.2095596127804;527.857478480808;543.9782408703687;548.7570652472153;6951.582905025714;7518.699252029857;7655.1962043985695;7688.0005599271735;7756.883646745303;451.6567408769359;487.39319547164007;535.657179405181;559.8236555485009;560.3975726094465;3334.982830236801;3382.289719158955;3440.071180781225;3501.842417091237;3518.296340731864;54717.452825472035;54817;54971;55383.723081384334;55472.445275547536;46343;46736;46738;46898;47739.76130119397;38750.224995500495;38813;38878.99999999943;41769.582304177784;43399;7144.642767861482;7417.258274172539;7508.962455187689;7513.511621744569;7638.8090297743;31987.92229476392;32564.34871302608;32685.509717353783;32735.83632081824;32765;34773.304533909686;38512;39917.401238980856;41518.1696366077;41657;4855.724103047948;5637.154426836008;6700;6786.083878676315;7041.612711300928;9881.752956175866;9914.504274786088;9919.057689519484;10013.299069065388;10669.146468282674;9234.307426942873;9271.258299336172;9314.20829229523;9330.673426430314;9353.579088941151;9212;9367.906320936703;9369.531523423939;9385.15533601979;9403.153716165578;8746.25656819152;9191.678291259774;9216.861747073664;9239.630414783333;9242.260619150586;8101.918980810116;8508.064112947695;8524.872126918226;8680.522571258642;8805.383623146317;7974.601269936596;8240.546769927712;8514;8548.914510854811;8560.828783424422 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1026 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: __startTimestamp1447815196833__endTimestamp 18:53:16 INFO - 2015-11-17 18:53:16,848 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4773.04 Median:4945.21 stddev:509.28 (10.3%) stddev-sans-first:486.61 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: Values: 2794.2 2824.1 2839.6 2879.7 3081.6 4586.3 4695.6 4768.4 4806.6 4924.7 4640.7 4685.8 4728.2 4734.6 4806.7 4352.1 4394.3 4430.7 4475.1 4568.9 4477.4 4507.2 4545.7 4555.2 4605.7 4215.1 4341.2 4390.0 4453.4 4580.8 4328.3 4416.1 4416.6 4435.4 4454.2 4394.4 4403.9 4404.5 4488.7 4553.2 4735.0 4742.4 4756.9 4777.7 4833.7 4928.9 5064.7 5098.2 5122.4 5160.2 5014.4 5067.5 5087.7 5121.1 5152.4 4741.5 4817.5 4839.7 4859.4 4923.0 5077.6 5134.4 5157.4 5188.1 5295.0 4884.0 4979.6 4986.3 5016.9 5124.5 5080.4 5083.6 5085.5 5126.9 5127.4 4827.2 5010.2 5028.7 5047.2 5115.0 4955.3 4970.2 4971.2 4986.4 5016.9 3851.2 3855.4 3902.7 3907.0 3918.1 3532.3 3536.7 3608.6 3611.0 3650.5 4739.1 4811.6 4812.9 4814.5 4868.7 4876.2 5067.5 5073.2 5085.8 5095.4 4867.1 4878.2 4880.4 4945.6 4953.4 4480.4 4571.1 4574.0 4577.7 4624.1 5035.5 5332.6 5353.1 5379.7 5427.1 5069.2 5096.4 5151.7 5156.3 5184.5 5343.3 5373.1 5373.4 5373.7 5419.6 4852.1 5001.7 5143.8 5147.8 5151.8 5102.0 5104.4 5132.4 5162.5 5192.6 5023.3 5047.1 5063.9 5075.1 5096.6 4819.7 4954.2 5037.5 5039.4 5076.8 4857.2 4888.6 4913.1 4945.2 4970.3 5043.5 5069.8 5078.9 5099.1 5150.0 4990.9 4995.2 5012.2 5053.2 5114.3 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,849 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40996.30 Median:31469.84 stddev:68115.53 (216.4%) stddev-sans-first:68238.75 18:53:16 INFO - 2015-11-17 18:53:16,851 DEBUG : BROWSER_OUTPUT: Values: 500.5 502.2 506.6 515.7 532.9 27438.6 28686.4 34599.5 34670.5 35323.6 37676.6 37912.8 37947.2 38393.0 38430.4 7311.4 8274.5 8324.4 8402.0 8524.0 7484.0 9890.7 9939.4 9990.2 10027.5 9778.2 9853.0 9860.3 9972.5 10000.7 7614.5 7772.6 9694.0 9809.4 9910.6 9651.7 9675.0 9787.0 9818.2 9851.5 34892.8 35295.0 35434.0 35681.3 35950.6 2671.8 2740.8 2773.5 2861.2 3105.7 24122.4 24262.8 24890.3 24978.3 25115.1 2063.3 2090.1 2099.9 2107.2 2215.8 222660.0 222917.0 223839.0 224350.0 227180.0 49413.3 50864.7 50934.7 51489.2 51533.0 47509.0 60813.4 62463.0 62606.0 62664.4 14478.4 14592.3 14793.9 14796.1 14817.0 10892.6 10934.5 11077.6 11218.2 11220.6 17001.6 17111.3 17131.7 17147.2 17365.8 7745.7 7855.6 7885.4 7947.6 7979.5 871.9 892.3 935.8 960.5 1008.2 24925.3 25184.7 25255.6 25267.2 25477.6 933.4 950.6 1017.0 1026.2 1032.6 12998.4 13024.5 13237.7 13249.2 13373.7 234838.0 241205.0 244246.0 244677.0 246286.0 48045.3 48073.5 48298.5 48313.0 48465.8 1251.4 1259.3 1272.9 1282.8 1283.1 24434.8 25178.7 25182.4 25393.4 25478.7 39093.6 43055.8 43189.6 43479.6 43675.0 167371.0 322318.0 334851.0 335555.0 336844.0 28089.9 28629.3 28663.7 28670.3 28807.9 35782.0 36238.3 37007.3 37085.4 37198.4 30532.1 31306.4 31466.7 31528.4 31746.4 30321.2 30929.5 31473.0 33786.0 34346.0 31323.5 31406.2 31967.0 32087.2 32131.4 26402.0 27725.2 27815.6 27956.3 28126.9 21440.6 21466.6 21565.2 21675.8 21680.7 18:53:16 INFO - 2015-11-17 18:53:16,851 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,851 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23773.27 Median:4252.06 stddev:77339.61 (1818.9%) stddev-sans-first:77536.46 18:53:16 INFO - 2015-11-17 18:53:16,852 DEBUG : BROWSER_OUTPUT: Values: 283.5 296.9 307.6 308.9 312.5 12661.6 12909.7 14980.0 14987.9 15185.5 10348.3 10729.7 10805.2 13748.1 15549.5 3848.2 3858.2 3875.8 3927.8 3940.3 3042.5 3130.4 3156.8 3752.9 3772.9 4140.0 4249.2 4254.9 4330.2 4367.0 4247.6 4258.1 4261.8 4290.4 4296.3 3545.9 3559.7 3562.9 3565.6 3610.0 11376.0 11439.8 11786.0 11793.8 11796.1 1648.3 1688.6 1735.8 1764.8 1875.4 8441.5 8545.1 8658.2 8868.2 8938.4 1400.8 1412.8 1476.7 1506.4 1545.7 50762.0 53479.7 53539.2 53952.7 54229.2 5785.2 5860.7 5936.2 5949.3 5967.0 6729.0 6731.2 6753.2 6806.4 6820.1 4936.0 4968.0 4982.6 5009.4 5009.7 5279.6 5343.8 5351.0 5378.3 5386.1 2657.2 2688.1 2712.5 2712.7 2713.0 941.1 943.5 949.8 954.8 984.8 340.7 345.9 347.5 357.9 358.3 8980.6 9305.6 9314.3 9483.3 9744.4 323.6 368.1 373.2 381.3 383.4 4712.6 5117.7 5124.7 5141.6 5226.3 455620.0 466565.0 470385.0 474807.0 492894.0 63121.4 64157.7 64320.0 64325.4 65089.3 392.3 394.4 396.6 396.9 400.0 8823.6 8864.2 8904.0 9080.0 9101.8 30311.5 30859.2 31044.2 31113.5 31275.5 41906.6 42337.8 42381.6 43044.8 43414.3 6907.1 6926.1 7036.9 7046.7 7073.2 10701.9 10735.2 10786.1 10789.7 10849.8 9083.0 9136.9 9226.0 9316.3 9391.1 7874.0 8189.0 8625.1 8810.6 8827.8 8415.9 8736.5 8948.0 9053.9 9181.6 13601.7 13824.5 13964.3 13973.6 14257.2 13165.8 13755.6 14044.5 14144.2 14167.4 18:53:16 INFO - 2015-11-17 18:53:16,853 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,853 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4551.29 Median:5915.92 stddev:2351.45 (39.7%) stddev-sans-first:2343.76 18:53:16 INFO - 2015-11-17 18:53:16,853 DEBUG : BROWSER_OUTPUT: Values: 1102.9 1172.7 1202.8 1208.0 1245.7 5600.7 5727.9 6337.6 6542.7 6633.9 6442.9 6452.1 6458.0 6483.9 6508.0 1707.3 1752.6 1948.3 1957.8 1967.8 1781.2 1782.2 1791.6 1801.0 1908.8 1886.9 1889.7 1890.3 1890.4 1907.7 1818.0 1847.7 1905.9 1916.1 1933.3 1909.6 1946.6 1962.0 1977.2 1982.5 6450.9 6531.7 6537.0 6540.3 6545.6 4057.6 4128.3 4130.7 4150.4 4157.3 2555.5 2586.5 2622.2 2645.0 2695.2 820.4 822.5 826.5 849.6 853.5 8629.4 8641.3 8644.8 8645.6 8651.6 3292.9 3618.5 3669.8 3698.4 3711.5 7075.7 7340.1 7581.2 7583.0 7655.7 3944.1 4063.9 4074.5 4085.6 4125.0 3629.8 3641.5 3648.6 3651.8 3673.2 2906.5 2916.2 2938.4 2958.1 2988.4 969.1 991.9 993.2 996.5 999.2 857.4 858.2 867.6 869.6 1097.5 6230.6 6241.8 6249.0 6266.5 6334.9 571.5 592.5 597.1 602.2 604.6 4969.9 4992.4 4995.3 5069.8 5095.1 7571.8 7615.9 7620.4 7704.2 7745.3 7559.7 7586.8 7598.6 7664.8 7689.8 5962.3 6057.8 6242.5 6245.4 6336.0 6160.9 6203.6 6204.1 6205.6 6291.1 6774.5 6925.7 6975.0 6983.0 7024.4 7117.0 7146.8 7191.0 7193.9 7210.3 5358.0 5507.1 5701.9 5791.6 5853.8 5913.2 6063.2 6180.1 6262.2 6285.0 5706.3 5791.7 5918.6 6014.3 6050.1 5775.6 5825.6 5923.7 5928.9 6007.1 5870.2 5885.4 5933.6 6024.6 6038.1 5491.1 5493.4 5505.9 5518.9 5566.5 5562.6 5574.1 5576.0 5600.7 5637.0 18:53:16 INFO - 2015-11-17 18:53:16,853 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,853 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4858.27 Median:5594.83 stddev:1490.98 (26.6%) stddev-sans-first:1455.05 18:53:16 INFO - 2015-11-17 18:53:16,855 DEBUG : BROWSER_OUTPUT: Values: 281.4 286.1 286.1 286.7 288.9 5452.8 5471.4 5492.9 5534.8 5540.9 5465.3 5477.3 5496.5 5528.4 5544.5 4195.2 4203.1 4214.1 4215.7 4223.9 4075.3 4127.5 4133.0 4148.8 4205.3 4138.7 4160.1 4171.3 4215.0 4220.5 4143.2 4159.6 4187.4 4205.5 4206.9 3462.3 3515.1 3548.5 3565.7 3657.2 5273.7 5307.3 5320.8 5383.6 5400.8 4728.9 4734.1 4748.2 4785.1 4786.6 5585.3 5747.2 5759.5 5801.6 5838.9 3948.8 3957.4 3974.2 3993.8 4004.7 6057.4 6069.8 6124.0 6140.2 6149.3 4023.4 4023.8 4026.9 4091.9 4092.2 4107.9 4110.7 4116.1 4125.3 4139.4 4059.7 4543.3 4564.9 4681.3 4781.8 5769.7 5788.9 5830.5 5867.7 5867.8 1430.4 1449.9 1454.4 1469.3 1471.3 948.8 964.9 970.6 979.9 982.0 5538.4 5567.5 5584.6 5621.1 5621.9 6013.2 6033.7 6071.7 6089.1 6124.5 5537.6 5554.3 5607.6 5636.3 5637.9 3162.7 3241.7 3243.8 3290.2 3307.8 6133.2 6167.3 6247.7 6262.7 6292.7 6167.6 6221.0 6231.8 6243.3 6245.0 6036.6 6143.4 6187.8 6203.5 6220.6 5989.1 6063.3 6091.5 6100.8 6134.3 5873.5 5887.5 5936.3 5951.5 5962.2 6165.8 6181.7 6235.3 6238.5 6280.4 3922.9 4000.4 4008.8 4014.8 4049.0 5853.7 6015.9 6083.1 6144.4 6145.9 5692.8 5726.0 5848.0 5942.1 5951.0 5813.0 5836.0 5851.2 5932.6 5958.4 5604.4 5682.1 5730.0 5779.3 5796.9 5840.9 5857.3 5869.7 5885.7 5930.6 5745.4 5807.9 5824.0 5825.7 5848.0 18:53:16 INFO - 2015-11-17 18:53:16,855 DEBUG : BROWSER_OUTPUT: 18:53:16 INFO - 2015-11-17 18:53:16,855 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12000.89 Median:30528.97 stddev:14469.20 (47.4%) stddev-sans-first:14484.70 18:53:16 INFO - 2015-11-17 18:53:16,857 DEBUG : BROWSER_OUTPUT: Values: 653.7 672.1 686.2 688.2 698.9 12232.7 12425.3 12458.3 12627.8 12660.9 11082.3 11527.9 11645.2 11652.8 12735.1 785.7 803.8 804.2 810.4 814.8 768.1 801.6 802.4 802.7 810.0 835.8 844.2 844.2 844.4 844.5 815.7 830.3 832.1 833.2 833.3 613.8 616.5 623.8 624.0 625.0 11777.9 11897.4 11928.1 11960.3 12026.1 9215.7 9757.7 10069.9 10193.9 10305.8 7970.8 8234.3 8253.6 8289.5 8508.3 2910.4 2989.1 3026.1 3038.7 3054.6 36921.8 37537.8 39748.6 41285.2 41390.0 7407.1 7623.6 7645.4 7648.7 7871.7 16163.7 16179.7 16265.8 16339.3 16377.8 5422.8 5422.9 5585.5 5967.7 6168.6 3513.9 3580.2 3626.8 3637.1 3660.6 2631.0 2642.4 2646.7 2654.5 2682.5 380.0 408.4 419.4 425.0 428.3 517.4 525.2 527.9 544.0 548.8 6951.6 7518.7 7655.2 7688.0 7756.9 451.7 487.4 535.7 559.8 560.4 3335.0 3382.3 3440.1 3501.8 3518.3 54717.5 54817.0 54971.0 55383.7 55472.4 46343.0 46736.0 46738.0 46898.0 47739.8 38750.2 38813.0 38879.0 41769.6 43399.0 7144.6 7417.3 7509.0 7513.5 7638.8 31987.9 32564.3 32685.5 32735.8 32765.0 34773.3 38512.0 39917.4 41518.2 41657.0 4855.7 5637.2 6700.0 6786.1 7041.6 9881.8 9914.5 9919.1 10013.3 10669.1 9234.3 9271.3 9314.2 9330.7 9353.6 9212.0 9367.9 9369.5 9385.2 9403.2 8746.3 9191.7 9216.9 9239.6 9242.3 8101.9 8508.1 8524.9 8680.5 8805.4 7974.6 8240.5 8514.0 8548.9 8560.8 18:53:16 INFO - 2015-11-17 18:53:16,857 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:16 INFO - 2015-11-17 18:53:16,857 DEBUG : BROWSER_OUTPUT: 18:53:17 INFO - 2015-11-17 18:53:17,534 INFO : Browser exited with error code: 0 18:53:17 INFO - 2015-11-17 18:53:17,564 INFO : Completed test dromaeo_css (00:18:35) 18:53:17 INFO - 2015-11-17 18:53:17,564 INFO : Starting test kraken 18:53:17 INFO - 2015-11-17 18:53:17,564 DEBUG : operating with platform_type : mac_ 18:53:17 INFO - 2015-11-17 18:53:17,565 INFO : Initialising browser for kraken test... 18:53:17 INFO - 2015-11-17 18:53:17,580 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpKKvVgp/profile http://localhost:49657/getInfo.html 18:53:20 INFO - 2015-11-17 18:53:20,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:53:20 INFO - 2015-11-17 18:53:20,132 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:53:20 INFO - 2015-11-17 18:53:20,132 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:53:20 INFO - 2015-11-17 18:53:20,133 DEBUG : BROWSER_OUTPUT: __metrics 18:53:20 INFO - 2015-11-17 18:53:20,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] 18:53:20 INFO - 2015-11-17 18:53:20,869 INFO : Browser initialized. 18:53:20 INFO - 2015-11-17 18:53:20,870 INFO : Running cycle 1/1 for kraken test... 18:53:20 INFO - 2015-11-17 18:53:20,870 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpKKvVgp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:32 INFO - 2015-11-17 18:53:32,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 228139008 18:53:32 INFO - 2015-11-17 18:53:32,981 DEBUG : BROWSER_OUTPUT: 18:53:35 INFO - 2015-11-17 18:53:35,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:36 INFO - 2015-11-17 18:53:36,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 285478912 18:53:36 INFO - 2015-11-17 18:53:36,164 DEBUG : BROWSER_OUTPUT: 18:53:39 INFO - 2015-11-17 18:53:39,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-dft) 18:53:39 INFO - 2015-11-17 18:53:39,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 299294720 18:53:39 INFO - 2015-11-17 18:53:39,658 DEBUG : BROWSER_OUTPUT: 18:53:42 INFO - 2015-11-17 18:53:42,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-fft) 18:53:43 INFO - 2015-11-17 18:53:43,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 281796608 18:53:43 INFO - 2015-11-17 18:53:43,467 DEBUG : BROWSER_OUTPUT: 18:53:45 INFO - 2015-11-17 18:53:45,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-oscillator) 18:53:46 INFO - 2015-11-17 18:53:46,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 283672576 18:53:46 INFO - 2015-11-17 18:53:46,218 DEBUG : BROWSER_OUTPUT: 18:53:48 INFO - 2015-11-17 18:53:48,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:49 INFO - 2015-11-17 18:53:49,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 284557312 18:53:49 INFO - 2015-11-17 18:53:49,134 DEBUG : BROWSER_OUTPUT: 18:53:52 INFO - 2015-11-17 18:53:52,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:53 INFO - 2015-11-17 18:53:53,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 285478912 18:53:53 INFO - 2015-11-17 18:53:53,082 DEBUG : BROWSER_OUTPUT: 18:53:56 INFO - 2015-11-17 18:53:56,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:57 INFO - 2015-11-17 18:53:57,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 285429760 18:53:57 INFO - 2015-11-17 18:53:57,121 DEBUG : BROWSER_OUTPUT: 18:54:00 INFO - 2015-11-17 18:54:00,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49657/tests/kraken/driver.html?testName=json-parse-financial) 18:54:00 INFO - 2015-11-17 18:54:00,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 285626368 18:54:00 INFO - 2015-11-17 18:54:00,802 DEBUG : BROWSER_OUTPUT: 18:54:02 INFO - 2015-11-17 18:54:02,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:54:03 INFO - 2015-11-17 18:54:03,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 318050304 18:54:03 INFO - 2015-11-17 18:54:03,044 DEBUG : BROWSER_OUTPUT: 18:54:05 INFO - 2015-11-17 18:54:05,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:54:05 INFO - 2015-11-17 18:54:05,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 319791104 18:54:05 INFO - 2015-11-17 18:54:05,650 DEBUG : BROWSER_OUTPUT: 18:54:07 INFO - 2015-11-17 18:54:07,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:54:08 INFO - 2015-11-17 18:54:08,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 327135232 18:54:08 INFO - 2015-11-17 18:54:08,474 DEBUG : BROWSER_OUTPUT: 18:54:11 INFO - 2015-11-17 18:54:11,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:11 INFO - 2015-11-17 18:54:11,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 328183808 18:54:11 INFO - 2015-11-17 18:54:11,895 DEBUG : BROWSER_OUTPUT: 18:54:14 INFO - 2015-11-17 18:54:14,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:15 INFO - 2015-11-17 18:54:15,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 328245248 18:54:15 INFO - 2015-11-17 18:54:15,360 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49657/tests/kraken/driver.html?testName=ai-astar) 18:54:17 INFO - 2015-11-17 18:54:17,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 387764224 18:54:17 INFO - 2015-11-17 18:54:17,474 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;105;101;117;116;105;105;108;113;117 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;172;151;176;191;147;167;166;149;189;148 18:54:17 INFO - 2015-11-17 18:54:17,476 DEBUG : BROWSER_OUTPUT: |2;audio-dft;175;181;182;183;182;182;186;182;180;180 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;89;100;99;82;82;85;95;97;77 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;106;151;98;106;105;144;99;98;141 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;138;135;138;135;135;129;129;142;132 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;142;148;146;142;141;142;142;148;144 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;110;109;109;110;109;104;109;109;118 18:54:17 INFO - 2015-11-17 18:54:17,477 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;63;63;67;67;66;68;80;68;69 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;74;75;79;80;80;83;83;82;80 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;97;99;103;100;100;97;98;99;96 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;145;154;146;137;143;156;147;146;148 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;174;173;179;187;173;176;162;173;165 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;80;80;81;83;83;84;83;81 18:54:17 INFO - 2015-11-17 18:54:17,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: __startTimestamp1447815257474__endTimestamp 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,479 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:17 INFO - 2015-11-17 18:54:17,481 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:54:17 INFO - 2015-11-17 18:54:17,481 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,481 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:5.98 (5.4%) stddev-sans-first:6.14 18:54:17 INFO - 2015-11-17 18:54:17,481 DEBUG : BROWSER_OUTPUT: Values: 105.0 105.0 101.0 117.0 116.0 105.0 105.0 108.0 113.0 117.0 18:54:17 INFO - 2015-11-17 18:54:17,481 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.60 Median:169.50 stddev:16.63 (9.8%) stddev-sans-first:17.47 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: Values: 172.0 151.0 176.0 191.0 147.0 167.0 166.0 149.0 189.0 148.0 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.30 Median:182.00 stddev:2.79 (1.5%) stddev-sans-first:1.80 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: Values: 175.0 181.0 182.0 183.0 182.0 182.0 186.0 182.0 180.0 180.0 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,482 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.60 Median:87.00 stddev:8.55 (9.8%) stddev-sans-first:8.49 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: Values: 80.0 89.0 100.0 99.0 82.0 82.0 85.0 95.0 97.0 77.0 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.50 Median:147.50 stddev:21.00 (14.2%) stddev-sans-first:22.05 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: Values: 107.0 106.0 151.0 98.0 106.0 105.0 144.0 99.0 98.0 141.0 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.80 Median:135.00 stddev:4.05 (3.0%) stddev-sans-first:4.29 18:54:17 INFO - 2015-11-17 18:54:17,483 DEBUG : BROWSER_OUTPUT: Values: 135.0 138.0 135.0 138.0 135.0 135.0 129.0 129.0 142.0 132.0 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:143.70 Median:143.00 stddev:2.67 (1.9%) stddev-sans-first:2.76 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 148.0 146.0 142.0 141.0 142.0 142.0 148.0 144.0 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:110.00 Median:109.50 stddev:3.56 (3.3%) stddev-sans-first:3.61 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 109.0 109.0 110.0 109.0 104.0 109.0 109.0 118.0 18:54:17 INFO - 2015-11-17 18:54:17,484 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.50 stddev:4.88 (7.2%) stddev-sans-first:5.01 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 67.0 67.0 66.0 68.0 80.0 68.0 69.0 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.70 Median:80.00 stddev:4.06 (5.1%) stddev-sans-first:3.21 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 75.0 79.0 80.0 80.0 83.0 83.0 82.0 80.0 18:54:17 INFO - 2015-11-17 18:54:17,485 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.10 Median:97.00 stddev:2.92 (3.0%) stddev-sans-first:2.11 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: Values: 92.0 97.0 99.0 103.0 100.0 100.0 97.0 98.0 99.0 96.0 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:146.50 stddev:5.38 (3.7%) stddev-sans-first:5.62 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: Values: 144.0 145.0 154.0 146.0 137.0 143.0 156.0 147.0 146.0 148.0 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.50 stddev:8.63 (5.0%) stddev-sans-first:7.28 18:54:17 INFO - 2015-11-17 18:54:17,486 DEBUG : BROWSER_OUTPUT: Values: 157.0 174.0 173.0 179.0 187.0 173.0 176.0 162.0 173.0 165.0 18:54:17 INFO - 2015-11-17 18:54:17,487 DEBUG : BROWSER_OUTPUT: 18:54:17 INFO - 2015-11-17 18:54:17,487 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.50 Median:82.00 stddev:3.34 (4.1%) stddev-sans-first:2.18 18:54:17 INFO - 2015-11-17 18:54:17,487 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 80.0 80.0 81.0 83.0 83.0 84.0 83.0 81.0 18:54:17 INFO - 2015-11-17 18:54:17,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:17 INFO - 2015-11-17 18:54:17,489 DEBUG : BROWSER_OUTPUT: 18:54:18 INFO - 2015-11-17 18:54:18,181 INFO : Browser exited with error code: 0 18:54:18 INFO - 2015-11-17 18:54:18,234 INFO : Completed test kraken (00:01:00) 18:54:18 INFO - 2015-11-17 18:54:18,234 INFO : Starting test v8_7 18:54:18 INFO - 2015-11-17 18:54:18,234 DEBUG : operating with platform_type : mac_ 18:54:18 INFO - 2015-11-17 18:54:18,234 INFO : Initialising browser for v8_7 test... 18:54:18 INFO - 2015-11-17 18:54:18,249 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpGt9YO8/profile http://localhost:49657/getInfo.html 18:54:20 INFO - 2015-11-17 18:54:20,595 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:54:20 INFO - 2015-11-17 18:54:20,595 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:54:20 INFO - 2015-11-17 18:54:20,595 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:54:20 INFO - 2015-11-17 18:54:20,595 DEBUG : BROWSER_OUTPUT: __metrics 18:54:20 INFO - 2015-11-17 18:54:20,616 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:54:21 INFO - 2015-11-17 18:54:21,434 INFO : Browser initialized. 18:54:21 INFO - 2015-11-17 18:54:21,435 INFO : Running cycle 1/1 for v8_7 test... 18:54:21 INFO - 2015-11-17 18:54:21,435 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/T/tmpGt9YO8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:54:33 INFO - 2015-11-17 18:54:33,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 230092800 18:54:33 INFO - 2015-11-17 18:54:33,487 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49657/tests/v8_7/run.html (next: http://localhost:49657/tests/v8_7/run.html) 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 728645632 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: |0;Richards;173.25017325017325 18:54:56 INFO - 2015-11-17 18:54:56,314 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;222.6179875333927 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.4022406938923 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6229.813664596273 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2155.1724137931033 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |5;Earley;991.0802775024777 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |6;Boyer;14428.57142857143 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |7;RegExp;35596.491228070176 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |8;Splay;846.740050804403 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6442.307692307692 18:54:56 INFO - 2015-11-17 18:54:56,315 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: __startTimestamp1447815296312__endTimestamp 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.25 Median:173.25 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: Values: 173.3 18:54:56 INFO - 2015-11-17 18:54:56,316 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:222.62 Median:222.62 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: Values: 222.6 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.40 Median:361.40 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: Values: 361.4 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6229.81 Median:6229.81 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: Values: 6229.8 18:54:56 INFO - 2015-11-17 18:54:56,317 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2155.17 Median:2155.17 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: Values: 2155.2 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:991.08 Median:991.08 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: Values: 991.1 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14428.57 Median:14428.57 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: Values: 14428.6 18:54:56 INFO - 2015-11-17 18:54:56,318 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35596.49 Median:35596.49 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: Values: 35596.5 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:846.74 Median:846.74 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: Values: 846.7 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: 18:54:56 INFO - 2015-11-17 18:54:56,319 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6442.31 Median:6442.31 stddev:0.00 (0.0%) 18:54:56 INFO - 2015-11-17 18:54:56,320 DEBUG : BROWSER_OUTPUT: Values: 6442.3 18:54:56 INFO - 2015-11-17 18:54:56,320 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:56 INFO - 2015-11-17 18:54:56,320 DEBUG : BROWSER_OUTPUT: 18:54:57 INFO - 2015-11-17 18:54:57,068 INFO : Browser exited with error code: 0 18:54:57 INFO - 2015-11-17 18:54:57,089 INFO : Completed test v8_7 (00:00:38) 18:54:57 INFO - 2015-11-17 18:54:57,324 INFO : Completed test suite (00:20:15) 18:54:57 INFO - 2015-11-17 18:54:57,324 DEBUG : Working with test: dromaeo_css 18:54:57 INFO - 2015-11-17 18:54:57,324 DEBUG : Generating results file: dromaeo_css 18:54:57 INFO - 2015-11-17 18:54:57,325 DEBUG : Working with test: kraken 18:54:57 INFO - 2015-11-17 18:54:57,326 DEBUG : Generating results file: kraken 18:54:57 INFO - 2015-11-17 18:54:57,326 INFO : javascript benchmark 18:54:57 INFO - 2015-11-17 18:54:57,326 DEBUG : Working with test: v8_7 18:54:57 INFO - 2015-11-17 18:54:57,326 DEBUG : Generating results file: v8_7 18:54:57 INFO - 2015-11-17 18:54:57,326 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:57 INFO - 2015-11-17 18:54:57,376 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 18:54:57 INFO - 2015-11-17 18:54:57,376 DEBUG : process_Request line: dromaeo_css 5888.12 graph.html#tests=[[72,64,55]] 18:54:57 INFO - 2015-11-17 18:54:57,376 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:57 INFO - 2015-11-17 18:54:57,405 DEBUG : process_Request line: kraken 1692.00 graph.html#tests=[[232,64,55]] 18:54:57 INFO - 2015-11-17 18:54:57,405 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:54:57 INFO - 2015-11-17 18:54:57,431 DEBUG : process_Request line: v8_7 16155.65 graph.html#tests=[[230,64,55]] 18:54:57 INFO - 2015-11-17 18:54:57,432 INFO : javascript benchmark 18:54:57 INFO - 2015-11-17 18:54:57,434 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [283.5109436222515, 296.904990403071, 307.6492798210041, 308.9397567474343, 312.46100476677725, 12661.620151395473, 12909.677258068554, 14979.999999999987, 14987.925060374697, 15185.544433666993, 10348.327358721677, 10729.678109656703, 10805.243632945698, 13748.106373085768, 15549.53351399457, 3848.2111167210796, 3858.151206734528, 3875.8255878485393, 3927.803609819512, 3940.290747665419, 3042.4675681755716, 3130.3582765533124, 3156.8421578921075, 3752.8874133775894, 3772.9434058489005, 4140.0, 4249.235137675218, 4254.893627659318, 4330.155619654169, 4367.03925136471, 4247.5540068293, 4258.148370325916, 4261.76560289184, 4290.442242508485, 4296.2696341621995, 3545.911352216215, 3559.7330200235087, 3562.893113206582, 3565.6434356564396, 3609.981950090259, 11376.0, 11439.771204575945, 11786.0, 11793.823092653616, 11796.115291353182, 1648.2747591060015, 1688.6285017296175, 1735.774349334591, 1764.7882254129586, 1875.353003213889, 8441.535715535643, 8545.145485451467, 8658.177473140042, 8868.246199073023, 8938.4190027648, 1400.8459069502346, 1412.8375236847792, 1476.6677497563069, 1506.3823832228734, 1545.667681448494, 50762.0, 53479.732601337135, 53539.19691204635, 53952.73023634896, 54229.1865622016, 5785.190073389729, 5860.706964651836, 5936.198613187251, 5949.345571987078, 5967.0, 6728.966355168192, 6731.1922569292, 6753.189617245962, 6806.353396427331, 6820.113385259884, 4936.0, 4967.950320496821, 4982.626303027288, 5009.373828271466, 5009.7495125243595, 5279.604029697788, 5343.786248550092, 5350.973245133828, 5378.273933019071, 5386.084365657769, 2657.216121244199, 2688.1263589333544, 2712.4710681417328, 2712.6609173853267, 2713.0368719104436, 941.0730430525927, 943.5329511891521, 949.8480243161061, 954.7660823098386, 984.7538115471132, 340.66784884737183, 345.9204382991926, 347.47704704419687, 357.9266250418658, 358.26198032054054, 8980.640774368952, 9305.627774889064, 9314.301427392973, 9483.28875334339, 9744.415335079917, 323.6003535633491, 368.1440650487627, 373.23486851953385, 381.28889620857456, 383.4248627059411, 4712.6229901607785, 5117.692938423706, 5124.666896651705, 5141.562967147759, 5226.268322434862, 455620.0, 466565.0, 470385.0, 474807.0, 492894.0, 63121.36878631155, 64157.679211603645, 64320.0, 64325.35674643287, 65089.349106509275, 392.30170296871614, 394.43004857979946, 396.56377984217704, 396.89482287193914, 400.01396557485356, 8823.602937867683, 8864.157904999014, 8904.0, 9080.046595107682, 9101.817963640558, 30311.545326819672, 30859.228519287197, 31044.22389440282, 31113.53329700011, 31275.530867036556, 41906.58093419149, 42337.78831105825, 42381.57618423776, 43044.78477607592, 43414.34878476762, 6907.067545881242, 6926.06498122747, 7036.894446583407, 7046.682899269443, 7073.221945586084, 10701.89298107009, 10735.194860385345, 10786.137109031102, 10789.730256743644, 10849.783004340026, 9082.954585227031, 9136.908630913871, 9226.031266716898, 9316.254699623878, 9391.060893910555, 7874.0, 8189.0, 8625.094365091574, 8810.647574096964, 8827.823443531222, 8415.915840841513, 8736.510094623001, 8948.0, 9053.909460905306, 9181.586828592863, 13601.659958501117, 13824.516141934984, 13964.30178491051, 13973.580792576238, 14257.215853128178, 13165.802512962506, 13755.587332380044, 14044.508442204473, 14144.151350918977, 14167.36246868914], "dojo.html": [2794.1617514745576, 2824.08217329368, 2839.6024556562083, 2879.7264259895314, 3081.5531747896553, 4586.289125185602, 4695.600873925712, 4768.403949506312, 4806.591439727623, 4924.729139897308, 4640.67515273931, 4685.812567497304, 4728.243481043034, 4734.644901632374, 4806.735629540374, 4352.12957408518, 4394.274944634131, 4430.689851710382, 4475.060237350161, 4568.862934111982, 4477.395551600524, 4507.233770259048, 4545.749983750892, 4555.225611646011, 4605.700629459091, 4215.093754842724, 4341.218580655481, 4390.034192477649, 4453.398791163184, 4580.839670611513, 4328.264195086811, 4416.138852923681, 4416.602505774464, 4435.401220835211, 4454.175977444151, 4394.384786129945, 4403.911921761547, 4404.471463424377, 4488.663350248712, 4553.225951588238, 4734.976325118352, 4742.407199100113, 4756.881077973044, 4777.665563410563, 4833.661643684944, 4928.852134435972, 5064.746762661852, 5098.2352647103235, 5122.436531981479, 5160.174372100483, 5014.448410674823, 5067.543921047087, 5087.745612719349, 5121.052605268037, 5152.433232344439, 4741.525847415231, 4817.470078291385, 4839.733814640158, 4859.416869975626, 4922.950770492285, 5077.593792496591, 5134.409542902539, 5157.355330583677, 5188.11801993662, 5295.046891559479, 4883.95116048835, 4979.601631869442, 4986.301917731521, 5016.949830501649, 5124.538791508782, 5080.390353157644, 5083.61872859537, 5085.542301192911, 5126.92309615356, 5127.359080114986, 4827.2035114206465, 5010.173321401928, 5028.698278103252, 5047.2429135629945, 5115.002574498011, 4955.281484184845, 4970.15507363749, 4971.1797553404, 4986.351774269322, 5016.874578135576, 3851.2490064437166, 3855.383138697795, 3902.687784977195, 3906.9609303906595, 3918.059665680273, 3532.2582257725653, 3536.664016918389, 3608.566971963381, 3610.9638903610626, 3650.452432135201, 4739.146953548395, 4811.639127065414, 4812.879678008007, 4814.518548145227, 4868.732219727878, 4876.195427754381, 5067.5185857343495, 5073.239014147834, 5085.771140298695, 5095.439501654815, 4867.099586576494, 4878.170710979142, 4880.365552478226, 4945.629077819178, 4953.380827396575, 4480.417545719036, 4571.062932098912, 4573.977130114328, 4577.679562430598, 4624.05206932578, 5035.471275516018, 5332.626716129834, 5353.063213937623, 5379.731013449312, 5427.0773968425465, 5069.239614057921, 5096.413912400121, 5151.7166555839785, 5156.303898973591, 5184.481551844785, 5343.305370301836, 5373.086575282289, 5373.35519737634, 5373.731313434235, 5419.647722897999, 4852.053849499313, 5001.724905130252, 5143.768530416065, 5147.794088236428, 5151.8196863109615, 5101.9744901276745, 5104.438511763778, 5132.409772876018, 5162.483751624958, 5192.558632516128, 5023.321851549994, 5047.116754567863, 5063.924041139459, 5075.086484432837, 5096.566791822736, 4819.662623616313, 4954.20732682769, 5037.496250374933, 5039.370078740158, 5076.82231121909, 4857.198562237191, 4888.633352498648, 4913.140200464976, 4945.208766597327, 4970.304157418037, 5043.52086551777, 5069.847904562869, 5078.873028174326, 5099.107656160231, 5150.0, 4990.900181996412, 4995.225740010304, 5012.223105418666, 5053.216751403538, 5114.284000239895], "mootools.html": [1102.9283096598726, 1172.677513683737, 1202.8255902894075, 1207.997362189383, 1245.7383949370635, 5600.747966341514, 5727.856803579913, 6337.619742815435, 6542.738290468375, 6633.867322653544, 6442.871142577157, 6452.128962590049, 6457.967710161454, 6483.870322593545, 6507.967460162693, 1707.2573430557686, 1752.6144248265362, 1948.3473036532778, 1957.8140076692691, 1967.7737060238112, 1781.198460692687, 1782.1623836796684, 1791.578978939948, 1800.97298540522, 1908.8186622270932, 1886.8584856135776, 1889.6598612249788, 1890.2816929566745, 1890.395073576456, 1907.7424547686023, 1817.990910045448, 1847.7136043913147, 1905.9332923347754, 1916.1090093106634, 1933.2846846666682, 1909.608530251309, 1946.6496030714466, 1961.9705704414446, 1977.2189984956005, 1982.5341044854447, 6450.870982580369, 6531.7387304507765, 6536.954087346049, 6540.2805691373915, 6545.607263564201, 4057.634812866856, 4128.339465685506, 4130.710850240484, 4150.377443383486, 4157.272477316457, 2555.527227462925, 2586.4697736963876, 2622.2264431992608, 2644.9603255951174, 2695.2049145502124, 820.4420993724265, 822.4818364430371, 826.5330088500039, 849.5582297205481, 853.4836423963475, 8629.352798540072, 8641.30869530436, 8644.783880402978, 8645.567721613894, 8651.567421628893, 3292.917677058045, 3618.5115009473384, 3669.7614655047337, 3698.352788262097, 3711.4989476420337, 7075.716971321192, 7340.082489688789, 7581.241875812485, 7583.014208152905, 7655.732049378245, 3944.1322908959983, 4063.878083657495, 4074.511058672919, 4085.632293093636, 4125.0, 3629.8185090745355, 3641.5083963664565, 3648.562172539312, 3651.7626354286886, 3673.2469843682516, 2906.5349544072847, 2916.154315248554, 2938.4270067337093, 2958.127352431038, 2988.44713727961, 969.060011788564, 991.8512223166583, 993.1806259835664, 996.531630133836, 999.2006394884064, 857.4298091769028, 858.1547176031604, 867.5922316511229, 869.5956380283199, 1097.5280629329304, 6230.56386052981, 6241.843953901189, 6248.968755156195, 6266.49868010558, 6334.904976425358, 571.5056476148102, 592.523018969725, 597.1192491075628, 602.2171177469272, 604.5888795618934, 4969.925451118163, 4992.400911890596, 4995.25071239317, 5069.822556210515, 5095.133827249377, 7571.848563028819, 7615.923840761632, 7620.3522700571075, 7704.191059938737, 7745.302922736981, 7559.697612095454, 7586.81032974169, 7598.620068996528, 7664.770056898302, 7689.846203075907, 5962.314333851576, 6057.848553786191, 6242.500599952084, 6245.406686364788, 6336.04959256106, 6160.907586386118, 6203.596766210362, 6204.069389591597, 6205.565610407409, 6291.056341548804, 6774.458043356618, 6925.653717314215, 6975.0, 6982.965085174542, 7024.438044956289, 7117.0, 7146.821329466805, 7191.0, 7193.892091618525, 7210.315020073084, 5357.973210133924, 5507.072524616352, 5701.914471283017, 5791.594588378773, 5853.799971005848, 5913.201717768046, 6063.242094738158, 6180.072989051679, 6262.1546091278915, 6284.968575157095, 5706.3152421709665, 5791.710414479175, 5918.644881307136, 6014.278286605635, 6050.0924861269405, 5775.624584402, 5825.563082768725, 5923.733431995484, 5928.851778705567, 6007.12896629995, 5870.207521984648, 5885.352611212848, 5933.584649074523, 6024.638521688713, 6038.124471951454, 5491.148871924858, 5493.395726470005, 5505.944940550543, 5518.944810551843, 5566.526845218202, 5562.554995600423, 5574.136008918624, 5576.0, 5600.691961942132, 5637.0135226334405], "ext.html": [500.5320025775899, 502.18144424587916, 506.55929341472927, 515.7189331814161, 532.8694469854886, 27438.5884211737, 28686.426271474586, 34599.4810077849, 34670.47994280088, 35323.64676353236, 37676.623233767656, 37912.81043594778, 37947.24105517895, 38393.0, 38430.423543646866, 7311.415086793044, 8274.503529788217, 8324.417290789617, 8401.95799021004, 8523.977122745278, 7484.02707648005, 9890.653827116052, 9939.40363578184, 9990.15182191297, 10027.498625068754, 9778.217742580611, 9852.95073524635, 9860.30977831552, 9972.451515166664, 10000.749981250454, 7614.505057171266, 7772.611369431505, 9694.0, 9809.362391444569, 9910.603575856992, 9651.71044868655, 9675.0, 9787.0, 9818.214542836557, 9851.458169800659, 34892.82553587216, 35295.0, 35434.0, 35681.28637427237, 35950.64049359499, 2671.7595416412423, 2740.7533322001113, 2773.5285001549787, 2861.1702606244166, 3105.6894310568987, 24122.39694007664, 24262.757372426226, 24890.253292401077, 24978.250652480456, 25115.12097076612, 2063.2778527515397, 2090.080364639554, 2099.8740075595515, 2107.2097963263777, 2215.767344428828, 222660.0, 222917.0, 223839.0, 224350.0, 227180.0, 49413.25880111801, 50864.745676271385, 50934.74532627313, 51489.22766158511, 51533.0, 47509.0, 60813.391866080776, 62463.0, 62606.0, 62664.37335626676, 14478.420863165566, 14592.343344549521, 14793.92603036978, 14796.112233266038, 14817.0, 10892.61875834342, 10934.507947142398, 11077.556897724162, 11218.158638102175, 11220.607278745369, 17001.574960626083, 17111.315547377966, 17131.657366852593, 17147.22837472292, 17365.826341736672, 7745.690172393154, 7855.60721963911, 7885.358404934296, 7947.642356093989, 7979.521228726295, 871.8605023196258, 892.3352102683542, 935.7707361696428, 960.5341409416427, 1008.193445243802, 24925.252242432754, 25184.74815251824, 25255.62116568253, 25267.241982740547, 25477.560529328675, 933.4446004627235, 950.5864948747317, 1016.9796604067877, 1026.1995643398013, 1032.6282538286212, 12998.415071321813, 13024.47902083906, 13237.669058273428, 13249.205047696976, 13373.732525349438, 234838.0, 241205.0, 244246.0, 244677.0, 246286.0, 48045.279320810216, 48073.519264807604, 48298.517014830104, 48313.0, 48465.75767121212, 1251.3993283224104, 1259.345140526939, 1272.885440310358, 1282.8139919711402, 1283.0569531394417, 24434.755652443248, 25178.74821251764, 25182.370440739127, 25393.365165870262, 25478.745212547637, 39093.609063908996, 43055.78472107745, 43189.56810431981, 43479.56520434755, 43675.0, 167371.0, 322318.0, 334851.0, 335555.0, 336844.0, 28089.859550702116, 28629.284267892635, 28663.71336286694, 28670.283242919093, 28807.8559607209, 35782.0, 36238.275234494635, 37007.259854802214, 37085.44371834479, 37198.44202337021, 30532.08403747891, 31306.373872522876, 31466.685333147292, 31528.36943261076, 31746.396772468324, 30321.24196895095, 30929.536056959612, 31473.0, 33786.0, 34346.0, 31323.53014704827, 31406.214844629067, 31967.040988770375, 32087.197820054684, 32131.357372851944, 26402.0, 27725.168244952685, 27815.582766258925, 27956.30109247285, 28126.85936570304, 21440.571188576454, 21466.570668586854, 21565.24521641735, 21675.783242168007, 21680.67478987785], "prototype.html": [281.4244869242399, 286.0545895814333, 286.0816778142163, 286.7476620573896, 288.8570157771903, 5452.809151679682, 5471.3707923588745, 5492.945070549298, 5534.833954981347, 5540.861478463041, 5465.316835395575, 5477.315335583052, 5496.532794712454, 5528.44715528447, 5544.473275038875, 4195.2029114468305, 4203.054312779615, 4214.093969796493, 4215.725977811432, 4223.915521689564, 4075.3071977763702, 4127.545969943304, 4132.966758310423, 4148.8133034013545, 4205.285101532747, 4138.730982486144, 4160.105577300879, 4171.332586786115, 4214.97892510537, 4220.493540775096, 4143.19207754488, 4159.604837540429, 4187.350960601112, 4205.537390887, 4206.852760153411, 3462.272922686239, 3515.1212196950764, 3548.520949671787, 3565.6969157621634, 3657.2319812839337, 5273.6572122811895, 5307.28351672527, 5320.787168513255, 5383.596230282745, 5400.756965936543, 4728.929066064012, 4734.100520901018, 4748.169070412664, 4785.114753770564, 4786.593139583139, 5585.301837270341, 5747.166660834156, 5759.539236861041, 5801.564882633819, 5838.883222335529, 3948.802559871995, 3957.3866050762176, 3974.1852920151587, 3993.7803420811842, 4004.659603933669, 6057.394260573996, 6069.848253793646, 6124.0, 6140.232470941132, 6149.3235744068115, 4023.3562629979647, 4023.75857448554, 4026.859059932888, 4091.8977025574004, 4092.1611069730634, 4107.876763697094, 4110.7328023678365, 4116.115035267432, 4125.29869922114, 4139.441175441337, 4059.65492933104, 4543.295789152687, 4564.88587785308, 4681.274402467623, 4781.760911954389, 5769.740361683735, 5788.942110578841, 5830.533557315404, 5867.735951882176, 5867.794627188114, 1430.3777856632398, 1449.8840092792552, 1454.4036944852771, 1469.3461409672807, 1471.3452513631546, 948.8054948735493, 964.8600952861796, 970.6020531582018, 979.8628192053118, 982.017982017982, 5538.44615538451, 5567.526760225426, 5584.609077364546, 5621.128725047624, 5621.915671264935, 6013.248343957005, 6033.668148251888, 6071.726772295257, 6089.086637004396, 6124.5100391968535, 5537.556995440355, 5554.333479982428, 5607.5513958884, 5636.267285252973, 5637.915431268534, 3162.6679198683805, 3241.6596257393107, 3243.772935894465, 3290.173953455855, 3307.751918606114, 6133.233345831771, 6167.259928808482, 6247.687615619201, 6262.718177682015, 6292.685365731695, 6167.5682702210415, 6221.0, 6231.813045608639, 6243.250809902841, 6245.0, 6036.577439579188, 6143.354947730513, 6187.783427579923, 6203.534734894901, 6220.564560480723, 5989.071693887455, 6063.272407311151, 6091.5126789857595, 6100.816975490565, 6134.325224225421, 5873.500752436091, 5887.499562537232, 5936.3470018297085, 5951.494122999594, 5962.19510366095, 6165.815025549241, 6181.690915454119, 6235.282942461675, 6238.500919926304, 6280.434760871361, 3922.941155882607, 4000.4398284669583, 4008.7995600219288, 4014.799260037045, 4049.0282332239462, 5853.678047707247, 6015.939840601538, 6083.117947897618, 6144.38556144382, 6145.877082458415, 5692.829215123553, 5726.0, 5847.970760146172, 5942.078977758454, 5951.018082016592, 5813.0, 5835.970820146042, 5851.239338885917, 5932.614380065282, 5958.404159584007, 5604.355499117653, 5682.119271512922, 5730.0, 5779.306483222041, 5796.884062318814, 5840.883182336414, 5857.26784151981, 5869.73586188614, 5885.705714714333, 5930.584859059997, 5745.396733343106, 5807.912881306699, 5824.0, 5825.737841797214, 5848.0], "yui.html": [653.6600967496905, 672.1262358933388, 686.1971493352777, 688.1535711075377, 698.853240819428, 12232.694182645428, 12425.254484730922, 12458.314792686399, 12627.810582841264, 12660.936695316534, 11082.335059896392, 11527.884721152786, 11645.18483706141, 11652.82520762187, 12735.108542402035, 785.6582386661792, 803.758872338299, 804.1596531624466, 810.4367464612097, 814.8044469327349, 768.1051574915217, 801.5951944268137, 802.3701394405393, 802.7391097893179, 809.9838003239931, 835.7910522369408, 844.160060739565, 844.1727107434717, 844.3751623798406, 844.501743971057, 815.7389635316702, 830.3191383065888, 832.0722394530115, 833.1751565949667, 833.2875391540236, 613.7514306705791, 616.4913945994573, 623.7692053940026, 624.0452108274347, 625.0124802811592, 11777.941110294394, 11897.405129743478, 11928.10539209554, 11960.282383057045, 12026.098042646836, 9215.677451289239, 9757.658481953098, 10069.949650251701, 10193.898061019368, 10305.793884122351, 7970.840583188304, 8234.300084492825, 8253.587320633944, 8289.544075075868, 8508.319334453228, 2910.432465669195, 2989.0584465893176, 3026.092172348309, 3038.6657467678538, 3054.618172728409, 36921.81539092314, 37537.81231093827, 39748.60251397478, 41285.1742965139, 41390.0, 7407.148177959496, 7623.618819059025, 7645.350145237606, 7648.694052237959, 7871.724489642835, 16163.676726465404, 16179.676406471805, 16265.83734162667, 16339.346426143058, 16377.754333685005, 5422.783088676409, 5422.945770542244, 5585.497305242467, 5967.671778052249, 6168.629882207082, 3513.894583162509, 3580.2481478889204, 3626.782393056425, 3637.0725465006253, 3660.633936606318, 2631.0, 2642.405458771799, 2646.7485588869026, 2654.4823759367123, 2682.463507298548, 379.9677027452698, 408.3507223514626, 419.4253872195051, 424.9893752656146, 428.282626600443, 517.3809204613751, 525.2095596127804, 527.857478480808, 543.9782408703687, 548.7570652472153, 6951.582905025714, 7518.699252029857, 7655.1962043985695, 7688.0005599271735, 7756.883646745303, 451.6567408769359, 487.39319547164007, 535.657179405181, 559.8236555485009, 560.3975726094465, 3334.982830236801, 3382.289719158955, 3440.071180781225, 3501.842417091237, 3518.296340731864, 54717.452825472035, 54817.0, 54971.0, 55383.723081384334, 55472.445275547536, 46343.0, 46736.0, 46738.0, 46898.0, 47739.76130119397, 38750.224995500495, 38813.0, 38878.99999999943, 41769.582304177784, 43399.0, 7144.642767861482, 7417.258274172539, 7508.962455187689, 7513.511621744569, 7638.8090297743, 31987.92229476392, 32564.34871302608, 32685.509717353783, 32735.83632081824, 32765.0, 34773.304533909686, 38512.0, 39917.401238980856, 41518.1696366077, 41657.0, 4855.724103047948, 5637.154426836008, 6700.0, 6786.083878676315, 7041.612711300928, 9881.752956175866, 9914.504274786088, 9919.057689519484, 10013.299069065388, 10669.146468282674, 9234.307426942873, 9271.258299336172, 9314.20829229523, 9330.673426430314, 9353.579088941151, 9212.0, 9367.906320936703, 9369.531523423939, 9385.15533601979, 9403.153716165578, 8746.25656819152, 9191.678291259774, 9216.861747073664, 9239.630414783333, 9242.260619150586, 8101.918980810116, 8508.064112947695, 8524.872126918226, 8680.522571258642, 8805.383623146317, 7974.601269936596, 8240.546769927712, 8514.0, 8548.914510854811, 8560.828783424422]}, "summary": {"lowerIsBetter": false, "suite": 5888.125427598151, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6059.883134566537, "unit": "ms", "value": 6059.883134566537}, "dojo.html": {"lowerIsBetter": false, "filtered": 4741.302274065221, "unit": "ms", "value": 4741.302274065221}, "mootools.html": {"lowerIsBetter": false, "filtered": 3696.2781226503444, "unit": "ms", "value": 3696.2781226503444}, "ext.html": {"lowerIsBetter": false, "filtered": 16659.22993815174, "unit": "ms", "value": 16659.22993815174}, "prototype.html": {"lowerIsBetter": false, "filtered": 4365.310917059171, "unit": "ms", "value": 4365.310917059171}, "yui.html": {"lowerIsBetter": false, "filtered": 5395.3723975823705, "unit": "ms", "value": 5395.3723975823705}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447814082, "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": "20151117175137", "branch": "Fx-Team", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}, {"talos_counters": {}, "results": {"audio-dft": [175.0, 181.0, 182.0, 183.0, 182.0, 182.0, 186.0, 182.0, 180.0, 180.0], "ai-astar": [105.0, 105.0, 101.0, 117.0, 116.0, 105.0, 105.0, 108.0, 113.0, 117.0], "imaging-gaussian-blur": [135.0, 138.0, 135.0, 138.0, 135.0, 135.0, 129.0, 129.0, 142.0, 132.0], "audio-beat-detection": [172.0, 151.0, 176.0, 191.0, 147.0, 167.0, 166.0, 149.0, 189.0, 148.0], "json-stringify-tinderbox": [71.0, 74.0, 75.0, 79.0, 80.0, 80.0, 83.0, 83.0, 82.0, 80.0], "stanford-crypto-pbkdf2": [157.0, 174.0, 173.0, 179.0, 187.0, 173.0, 176.0, 162.0, 173.0, 165.0], "json-parse-financial": [64.0, 63.0, 63.0, 67.0, 67.0, 66.0, 68.0, 80.0, 68.0, 69.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 80.0, 80.0, 81.0, 83.0, 83.0, 84.0, 83.0, 81.0], "audio-fft": [80.0, 89.0, 100.0, 99.0, 82.0, 82.0, 85.0, 95.0, 97.0, 77.0], "imaging-darkroom": [142.0, 142.0, 148.0, 146.0, 142.0, 141.0, 142.0, 142.0, 148.0, 144.0], "stanford-crypto-ccm": [144.0, 145.0, 154.0, 146.0, 137.0, 143.0, 156.0, 147.0, 146.0, 148.0], "audio-oscillator": [107.0, 106.0, 151.0, 98.0, 106.0, 105.0, 144.0, 99.0, 98.0, 141.0], "stanford-crypto-aes": [92.0, 97.0, 99.0, 103.0, 100.0, 100.0, 97.0, 98.0, 99.0, 96.0], "imaging-desaturate": [113.0, 110.0, 109.0, 109.0, 110.0, 109.0, 104.0, 109.0, 109.0, 118.0]}, "summary": {"lowerIsBetter": true, "suite": 1692.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 88.6, "unit": "ms", "value": 88.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 171.9, "unit": "ms", "value": 171.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 165.6, "unit": "ms", "value": 165.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 115.5, "unit": "ms", "value": 115.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 181.3, "unit": "ms", "value": 181.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 80.5, "unit": "ms", "value": 80.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 78.7, "unit": "ms", "value": 78.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 134.8, "unit": "ms", "value": 134.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 98.1, "unit": "ms", "value": 98.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447814082, "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": "20151117175137", "branch": "Fx-Team", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [222.6179875333927], "Encrypt": [361.4022406938923], "NavierStokes": [6442.307692307692], "Decrypt": [6229.813664596273], "Splay": [846.740050804403], "Richards": [173.25017325017325], "RegExp": [35596.491228070176], "Earley": [991.0802775024777], "Boyer": [14428.57142857143], "RayTrace": [2155.1724137931033]}, "summary": {"lowerIsBetter": false, "suite": 16155.647051898843, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 297.002056, "unit": "score", "value": 297.002056}, "Encrypt": {"lowerIsBetter": false, "filtered": 736.5228270000001, "unit": "score", "value": 736.5228270000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 230.35223880597022, "unit": "score", "value": 230.35223880597022}, "Decrypt": {"lowerIsBetter": false, "filtered": 42.72696011964105, "unit": "score", "value": 42.72696011964105}, "Splay": {"lowerIsBetter": false, "filtered": 96.24087100000004, "unit": "score", "value": 96.24087100000004}, "RegExp": {"lowerIsBetter": false, "filtered": 25.59198866436668, "unit": "score", "value": 25.59198866436668}, "Richards": {"lowerIsBetter": false, "filtered": 203.76314400000004, "unit": "score", "value": 203.76314400000004}, "Earley": {"lowerIsBetter": false, "filtered": 672.4611669999999, "unit": "score", "value": 672.4611669999999}, "Boyer": {"lowerIsBetter": false, "filtered": 46.190504950495075, "unit": "score", "value": 46.190504950495075}, "RayTrace": {"lowerIsBetter": false, "filtered": 343.35489599999994, "unit": "score", "value": 343.35489599999994}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0025"}, "testrun": {"date": 1447814082, "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": "20151117175137", "branch": "Fx-Team", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}] 18:54:57 INFO - RETURN: dromaeo_css: 5888.12 18:54:57 INFO - RETURN: kraken: 1692.00 18:54:57 INFO - RETURN: v8_7: 16155.65 18:54:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16155.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1692.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5888.12"}}} 18:54:57 INFO - Return code: 0 18:54:57 INFO - # TBPL SUCCESS # 18:54:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:54:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:54:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:54:57 INFO - 2015-11-17 18:54:57.537 screenresolution[1946:13578] starting screenresolution argv=screenresolution get 18:54:57 INFO - 2015-11-17 18:54:57.541 screenresolution[1946:13578] Display 0: 1600x1200x32@60 18:54:57 INFO - 2015-11-17 18:54:57.547 screenresolution[1947:13581] starting screenresolution argv=screenresolution list 18:54:57 INFO - Available Modes on Display 0 18:54:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:54:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:54:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:54:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:54:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:54:57 INFO - Intel HD Graphics 3000: 18:54:57 INFO - Chipset Model: Intel HD Graphics 3000 18:54:57 INFO - Type: GPU 18:54:57 INFO - Bus: Built-In 18:54:57 INFO - VRAM (Total): 512 MB 18:54:57 INFO - VRAM (Dynamic, Max): 10 18:54:57 INFO - Vendor: Intel (0x8086) 18:54:57 INFO - Device ID: 0x0116 18:54:57 INFO - Revision ID: 0x0009 18:54:57 INFO - Displays: 18:54:57 INFO - Display: 18:54:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:54:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:54:57 INFO - Display Serial Number: 1600x1200 60 18:54:57 INFO - Main Display: Yes 18:54:57 INFO - Mirror: Off 18:54:57 INFO - Online: Yes 18:54:57 INFO - Rotation: Supported 18:54:57 INFO - Return code: 0 18:54:57 INFO - Running post-action listener: _resource_record_post_action 18:54:57 INFO - Running post-run listener: _resource_record_post_run 18:54:58 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 36864; Write bytes: 689652736; Read time: 99; Write time: 71838 18:54:58 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 339268096; Write bytes: 335554560; Read time: 34371; Write time: 6463 18:54:58 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 32768; Write bytes: 342678528; Read time: 74; Write time: 59512 18:54:58 INFO - Running post-run listener: _upload_blobber_files 18:54:58 INFO - Blob upload gear active. 18:54:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:54:58 INFO - Copying logs to upload dir... 18:54:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.351859 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-17 18:54:58.963852) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:54:58.969883) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010063 build_url: 'https://queue.taskcluster.net/v1/task/mmkKbZf-TimXm_kalOOZoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:54:58.995740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:54:58.996076) ========= 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.p18YyrQYQW/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.rZdrys72m3/Listeners TMPDIR=/var/folders/_8/2lqr7c5x071f9gmmkyvxp58w00000w/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.005167 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:54:59.045285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:54:59.045630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:54:59.046020) ========= ========= Total master_lag: 0.33 =========