builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0044 starttime: 1447725330.84 results: success (0) buildid: 20151116154007 builduid: 453f37f0f603404e8d1be22461a7c4e0 revision: ffe020f9145296f68d56866b01ffe1d35ac18b83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.844550) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.845113) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.845531) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.006331 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.872490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.873197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.895895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.896329) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.005321 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.949302) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.949666) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.950104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:30.950416) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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-16 17:55:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-16 17:55:31 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.074537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.077951) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.019683 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.127522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.130942) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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-16 17:55:31,211 truncating revision to first 12 chars 2015-11-16 17:55:31,211 Setting DEBUG logging. 2015-11-16 17:55:31,211 attempt 1/10 2015-11-16 17:55:31,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffe020f91452?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 17:55:31,460 unpacking tar archive at: mozilla-central-ffe020f91452/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.825462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.825855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.842693) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.843036) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 17:55:31.843494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-16 17:55:31.843845) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:55:32 INFO - MultiFileLogger online at 20151116 17:55:32 in /builds/slave/test 17:55:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:55:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:32 INFO - {'append_to_log': False, 17:55:32 INFO - 'base_work_dir': '/builds/slave/test', 17:55:32 INFO - 'blob_upload_branch': 'Firefox', 17:55:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:32 INFO - 'branch': 'Firefox', 17:55:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:32 INFO - 'config_files': ('talos/mac_config.py',), 17:55:32 INFO - 'default_actions': ('clobber', 17:55:32 INFO - 'read-buildbot-config', 17:55:32 INFO - 'download-and-extract', 17:55:32 INFO - 'populate-webroot', 17:55:32 INFO - 'create-virtualenv', 17:55:32 INFO - 'install', 17:55:32 INFO - 'run-tests'), 17:55:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:32 INFO - 'download_minidump_stackwalk': True, 17:55:32 INFO - 'download_symbols': 'ondemand', 17:55:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:32 INFO - 'installer_path': 'installer.exe', 17:55:32 INFO - 'log_level': 'info', 17:55:32 INFO - 'log_name': 'talos', 17:55:32 INFO - 'log_to_console': True, 17:55:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:55:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:55:32 INFO - 'opt_config_files': (), 17:55:32 INFO - 'pip_index': False, 17:55:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:55:32 INFO - 'cmd': ('bash', 17:55:32 INFO - '-c', 17:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:55:32 INFO - 'enabled': True, 17:55:32 INFO - 'halt_on_failure': False, 17:55:32 INFO - 'name': 'check_screen_resolution'},), 17:55:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:55:32 INFO - 'cmd': ('bash', 17:55:32 INFO - '-c', 17:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:55:32 INFO - 'enabled': True, 17:55:32 INFO - 'halt_on_failure': False, 17:55:32 INFO - 'name': 'check_screen_resolution'},), 17:55:32 INFO - 'run_cmd_checks_enabled': True, 17:55:32 INFO - 'sps_profile': False, 17:55:32 INFO - 'sps_profile_interval': 0, 17:55:32 INFO - 'suite': 'dromaeojs', 17:55:32 INFO - 'system_bits': '64', 17:55:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:32 INFO - 'title': 't-yosemite-r5-0044', 17:55:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:32 INFO - 'use_talos_json': True, 17:55:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:32 INFO - 'work_dir': 'build'} 17:55:32 INFO - ##### 17:55:32 INFO - ##### Running clobber step. 17:55:32 INFO - ##### 17:55:32 INFO - Running pre-action listener: _resource_record_pre_action 17:55:32 INFO - Running main action method: clobber 17:55:32 INFO - rmtree: /builds/slave/test/build 17:55:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:35 INFO - Running post-action listener: _resource_record_post_action 17:55:35 INFO - ##### 17:55:35 INFO - ##### Running read-buildbot-config step. 17:55:35 INFO - ##### 17:55:35 INFO - Running pre-action listener: _resource_record_pre_action 17:55:35 INFO - Running main action method: read_buildbot_config 17:55:35 INFO - Using buildbot properties: 17:55:35 INFO - { 17:55:35 INFO - "properties": { 17:55:35 INFO - "buildnumber": 562, 17:55:35 INFO - "product": "firefox", 17:55:35 INFO - "script_repo_revision": "production", 17:55:35 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 17:55:35 INFO - "repository": "", 17:55:35 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 17:55:35 INFO - "buildid": "20151116154007", 17:55:35 INFO - "slavename": "t-yosemite-r5-0044", 17:55:35 INFO - "pgo_build": "False", 17:55:35 INFO - "basedir": "/builds/slave/test", 17:55:35 INFO - "project": "", 17:55:35 INFO - "platform": "yosemite", 17:55:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:55:35 INFO - "slavebuilddir": "test", 17:55:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:55:35 INFO - "branch": "mozilla-central", 17:55:35 INFO - "repo_path": "mozilla-central", 17:55:35 INFO - "stage_platform": "macosx64", 17:55:35 INFO - "builduid": "453f37f0f603404e8d1be22461a7c4e0", 17:55:35 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 17:55:35 INFO - }, 17:55:35 INFO - "sourcestamp": { 17:55:35 INFO - "repository": "", 17:55:35 INFO - "hasPatch": false, 17:55:35 INFO - "project": "", 17:55:35 INFO - "branch": "mozilla-central-macosx64-talos", 17:55:35 INFO - "changes": [ 17:55:35 INFO - { 17:55:35 INFO - "category": null, 17:55:35 INFO - "files": [ 17:55:35 INFO - { 17:55:35 INFO - "url": null, 17:55:35 INFO - "name": "https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:55:35 INFO - } 17:55:35 INFO - ], 17:55:35 INFO - "repository": "", 17:55:35 INFO - "rev": "ffe020f9145296f68d56866b01ffe1d35ac18b83", 17:55:35 INFO - "who": "kwierso@gmail.com", 17:55:35 INFO - "when": 1447724706, 17:55:35 INFO - "number": 6669397, 17:55:35 INFO - "comments": "Merge b2ginbound to central, a=merge", 17:55:35 INFO - "project": "", 17:55:35 INFO - "at": "Mon 16 Nov 2015 17:45:06", 17:55:35 INFO - "branch": "mozilla-central-macosx64-talos", 17:55:35 INFO - "revlink": "", 17:55:35 INFO - "properties": [ 17:55:35 INFO - [ 17:55:35 INFO - "buildid", 17:55:35 INFO - "20151116154007", 17:55:35 INFO - "Change" 17:55:35 INFO - ], 17:55:35 INFO - [ 17:55:35 INFO - "builduid", 17:55:35 INFO - "453f37f0f603404e8d1be22461a7c4e0", 17:55:35 INFO - "Change" 17:55:35 INFO - ], 17:55:35 INFO - [ 17:55:35 INFO - "pgo_build", 17:55:35 INFO - "False", 17:55:35 INFO - "Change" 17:55:35 INFO - ] 17:55:35 INFO - ], 17:55:35 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 17:55:35 INFO - } 17:55:35 INFO - ], 17:55:35 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 17:55:35 INFO - } 17:55:35 INFO - } 17:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:55:35 INFO - Running post-action listener: _resource_record_post_action 17:55:35 INFO - ##### 17:55:35 INFO - ##### Running download-and-extract step. 17:55:35 INFO - ##### 17:55:35 INFO - Running pre-action listener: _resource_record_pre_action 17:55:35 INFO - Running main action method: download_and_extract 17:55:35 INFO - mkdir: /builds/slave/test/build/tests 17:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:35 INFO - https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/test_packages.json 17:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/test_packages.json 17:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:55:35 INFO - Downloaded 1149 bytes. 17:55:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:55:35 INFO - Using the following test package requirements: 17:55:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:55:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:55:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'jsshell-mac.zip'], 17:55:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:55:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:55:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:55:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:55:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:55:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:55:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:55:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:55:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:35 INFO - https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:36 INFO - Downloaded 17464127 bytes. 17:55:36 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 17:55:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:55:41 INFO - Return code: 0 17:55:41 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 17:55: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')]} 17:55:41 INFO - https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:43 INFO - Downloaded 17464127 bytes. 17:55:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 17:55:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:55:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:55:48 INFO - Return code: 0 17:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:48 INFO - https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:50 INFO - Downloaded 11131693 bytes. 17:55:50 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 17:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:55:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:55:50 INFO - Return code: 0 17:55: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')]} 17:55:50 INFO - https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:55:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:55:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:55:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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 17:55:55 INFO - Downloaded 108693917 bytes. 17:55:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:55:55 INFO - mkdir: /builds/slave/test/properties 17:55:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:55 INFO - Contents: 17:55:55 INFO - build_url:https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:55:55 INFO - Running post-action listener: _resource_record_post_action 17:55:55 INFO - Running post-action listener: set_extra_try_arguments 17:55:55 INFO - ##### 17:55:55 INFO - ##### Running populate-webroot step. 17:55:55 INFO - ##### 17:55:55 INFO - Running pre-action listener: _resource_record_pre_action 17:55:55 INFO - Running main action method: populate_webroot 17:55:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:55:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:55:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:55:55 INFO - '../fennec_ids.txt'], 17:55:55 INFO - 'tests': ['tcheck2']}, 17:55:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:55:55 INFO - '--tppagecycles', 17:55:55 INFO - '7'], 17:55:55 INFO - 'tests': ['tsvgm']}}, 17:55:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:55:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:55:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:55:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'tests': ['damp', 'tps']}, 17:55:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['damp', 'tps']}, 17:55:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:55 INFO - 'other': {'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'other_l64': {'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'other_nol64': {'tests': ['a11yr', 17:55:55 INFO - 'ts_paint', 17:55:55 INFO - 'tpaint', 17:55:55 INFO - 'sessionrestore', 17:55:55 INFO - 'sessionrestore_no_auto_restore']}, 17:55:55 INFO - 'svgr': {'tests': ['tsvgx', 17:55:55 INFO - 'tsvgr_opacity', 17:55:55 INFO - 'tart', 17:55:55 INFO - 'tscrollx', 17:55:55 INFO - 'cart']}, 17:55:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['tsvgx', 17:55:55 INFO - 'tsvgr_opacity', 17:55:55 INFO - 'tart', 17:55:55 INFO - 'tscrollx', 17:55:55 INFO - 'cart']}, 17:55:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'tests': ['tp5o']}, 17:55:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'talos_options': ['--e10s'], 17:55:55 INFO - 'tests': ['tp5o']}, 17:55:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'talos_options': ['--xperf_path', 17:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:55 INFO - 'tests': ['tp5n']}, 17:55:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:55 INFO - 'talos_options': ['--e10s', 17:55:55 INFO - '--xperf_path', 17:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:55 INFO - 'tests': ['tp5n']}}, 17:55:55 INFO - 'talos.zip': {'path': '', 17:55:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:55:55 INFO - Running post-action listener: _resource_record_post_action 17:55:55 INFO - ##### 17:55:55 INFO - ##### Running create-virtualenv step. 17:55:55 INFO - ##### 17:55:55 INFO - Running pre-action listener: _resource_record_pre_action 17:55:55 INFO - Running main action method: create_virtualenv 17:55:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:55 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 17:55:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:56 INFO - Using real prefix '/tools/python27' 17:55:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:00 INFO - Installing pip.................done. 17:56:00 INFO - Return code: 0 17:56:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:00 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')]} 17:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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')]} 17:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:00 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 17:56:00 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 17:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:00 INFO - 'HOME': '/Users/cltbld', 17:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:00 INFO - 'LOGNAME': 'cltbld', 17:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:00 INFO - 'MOZ_NO_REMOTE': '1', 17:56:00 INFO - 'NO_EM_RESTART': '1', 17:56:00 INFO - 'PAGER': '/bin/cat', 17:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:00 INFO - 'PWD': '/builds/slave/test', 17:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:00 INFO - 'SHELL': '/bin/bash', 17:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:00 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:00 INFO - 'USER': 'cltbld', 17:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:00 INFO - 'XPC_FLAGS': '0x0', 17:56:00 INFO - 'XPC_SERVICE_NAME': '0', 17:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:00 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 17:56:00 INFO - Cleaning up... 17:56:00 INFO - Return code: 0 17:56:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:56:00 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')]} 17:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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')]} 17:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:00 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:00 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 17:56:00 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 17:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:00 INFO - 'HOME': '/Users/cltbld', 17:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:00 INFO - 'LOGNAME': 'cltbld', 17:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:00 INFO - 'MOZ_NO_REMOTE': '1', 17:56:00 INFO - 'NO_EM_RESTART': '1', 17:56:00 INFO - 'PAGER': '/bin/cat', 17:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:00 INFO - 'PWD': '/builds/slave/test', 17:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:00 INFO - 'SHELL': '/bin/bash', 17:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:00 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:00 INFO - 'USER': 'cltbld', 17:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:00 INFO - 'XPC_FLAGS': '0x0', 17:56:00 INFO - 'XPC_SERVICE_NAME': '0', 17:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:01 INFO - Downloading/unpacking psutil>=0.7.1 17:56:01 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 17:56:01 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 17:56:01 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 17:56:01 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 17:56:01 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 17:56:01 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 17:56:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:03 INFO - Installing collected packages: psutil 17:56:03 INFO - Running setup.py install for psutil 17:56:03 INFO - building 'psutil._psutil_osx' extension 17:56:03 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 INFO - building 'psutil._psutil_posix' extension 17:56:04 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 17:56:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:56:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:56:04 INFO - ^ 17:56:04 INFO - 1 warning generated. 17:56:04 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 17:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:04 INFO - Successfully installed psutil 17:56:04 INFO - Cleaning up... 17:56:04 INFO - Return code: 0 17:56:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:56:04 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')]} 17:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:04 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')]} 17:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:04 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:04 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 17:56:04 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 17:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:04 INFO - 'HOME': '/Users/cltbld', 17:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:04 INFO - 'LOGNAME': 'cltbld', 17:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:04 INFO - 'MOZ_NO_REMOTE': '1', 17:56:04 INFO - 'NO_EM_RESTART': '1', 17:56:04 INFO - 'PAGER': '/bin/cat', 17:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:04 INFO - 'PWD': '/builds/slave/test', 17:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:04 INFO - 'SHELL': '/bin/bash', 17:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:04 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:04 INFO - 'USER': 'cltbld', 17:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:04 INFO - 'XPC_FLAGS': '0x0', 17:56:04 INFO - 'XPC_SERVICE_NAME': '0', 17:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:56:07 INFO - Installing collected packages: mozsystemmonitor 17:56:07 INFO - Running setup.py install for mozsystemmonitor 17:56:07 INFO - Successfully installed mozsystemmonitor 17:56:07 INFO - Cleaning up... 17:56:07 INFO - Return code: 0 17:56:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:07 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')]} 17:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:07 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')]} 17:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:07 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:07 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 17:56:07 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 17:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:07 INFO - 'HOME': '/Users/cltbld', 17:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:07 INFO - 'LOGNAME': 'cltbld', 17:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:07 INFO - 'MOZ_NO_REMOTE': '1', 17:56:07 INFO - 'NO_EM_RESTART': '1', 17:56:07 INFO - 'PAGER': '/bin/cat', 17:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:07 INFO - 'PWD': '/builds/slave/test', 17:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:07 INFO - 'SHELL': '/bin/bash', 17:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:07 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:07 INFO - 'USER': 'cltbld', 17:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:07 INFO - 'XPC_FLAGS': '0x0', 17:56:07 INFO - 'XPC_SERVICE_NAME': '0', 17:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:07 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 17:56:07 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 17:56:07 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 17:56:07 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 17:56:07 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 17:56:07 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 17:56:10 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:10 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 17:56:10 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 17:56:10 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 17:56:10 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 17:56:10 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 17:56:10 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 17:56:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:11 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 17:56:11 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 17:56:11 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 17:56:11 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 17:56:11 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 17:56:11 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 17:56:11 INFO - Downloading docopt-0.6.1.tar.gz 17:56:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:11 INFO - Running setup.py install for blobuploader 17:56:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:11 INFO - Running setup.py install for requests 17:56:12 INFO - Running setup.py install for docopt 17:56:12 INFO - Successfully installed blobuploader requests docopt 17:56:12 INFO - Cleaning up... 17:56:12 INFO - Return code: 0 17:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:12 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:12 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 17:56:12 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 17:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:12 INFO - 'HOME': '/Users/cltbld', 17:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:12 INFO - 'LOGNAME': 'cltbld', 17:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:12 INFO - 'MOZ_NO_REMOTE': '1', 17:56:12 INFO - 'NO_EM_RESTART': '1', 17:56:12 INFO - 'PAGER': '/bin/cat', 17:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:12 INFO - 'PWD': '/builds/slave/test', 17:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:12 INFO - 'SHELL': '/bin/bash', 17:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:12 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:12 INFO - 'USER': 'cltbld', 17:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:12 INFO - 'XPC_FLAGS': '0x0', 17:56:12 INFO - 'XPC_SERVICE_NAME': '0', 17:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:12 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-0BP91G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:12 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-DA2zIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-yB7Evh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-1hOLmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-64Vy1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-WgAcfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-VOHKU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-7A8yp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-DsZw7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:13 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-x9CaB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-mV8moo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-JrYQRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-atDGPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-cqhjdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-wD8YqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-L1dDtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:14 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-vaiyw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:14 INFO - Running setup.py install for manifestparser 17:56:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozcrash 17:56:15 INFO - Running setup.py install for mozdebug 17:56:15 INFO - Running setup.py install for mozdevice 17:56:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozfile 17:56:15 INFO - Running setup.py install for mozhttpd 17:56:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozinfo 17:56:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Running setup.py install for mozInstall 17:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Running setup.py install for mozleak 17:56:16 INFO - Running setup.py install for mozlog 17:56:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Running setup.py install for moznetwork 17:56:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Running setup.py install for mozprocess 17:56:16 INFO - Running setup.py install for mozprofile 17:56:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Running setup.py install for mozrunner 17:56:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Running setup.py install for mozscreenshot 17:56:17 INFO - Running setup.py install for moztest 17:56:17 INFO - Running setup.py install for mozversion 17:56:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:17 INFO - Cleaning up... 17:56:17 INFO - Return code: 0 17:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:17 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')]} 17:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:17 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')]} 17:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:17 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:17 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 17:56:17 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 17:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:17 INFO - 'HOME': '/Users/cltbld', 17:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:17 INFO - 'LOGNAME': 'cltbld', 17:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:17 INFO - 'MOZ_NO_REMOTE': '1', 17:56:17 INFO - 'NO_EM_RESTART': '1', 17:56:17 INFO - 'PAGER': '/bin/cat', 17:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:17 INFO - 'PWD': '/builds/slave/test', 17:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:17 INFO - 'SHELL': '/bin/bash', 17:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:17 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:17 INFO - 'USER': 'cltbld', 17:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:17 INFO - 'XPC_FLAGS': '0x0', 17:56:17 INFO - 'XPC_SERVICE_NAME': '0', 17:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-kGqKfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-lC5enl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-MbrTST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-2VxVgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-ik8bZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-Eyj7lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-aGjOPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:18 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)) 17:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:18 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-zid7d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-utOgjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-i6DTeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-vP9DHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-SwuXKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-KVSctw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-7gTK_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-pXeHxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:19 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)) 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:19 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-Hpamij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:20 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)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:20 INFO - Running setup.py (path:/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/pip-Ajof2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:20 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)) 17:56:20 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)) 17:56:20 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)) 17:56:20 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)) 17:56:20 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)) 17:56:20 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)) 17:56:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:20 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 17:56:20 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 17:56:20 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 17:56:20 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 17:56:20 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 17:56:20 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 17:56:22 INFO - Downloading blessings-1.5.1.tar.gz 17:56:22 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 17:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:22 INFO - Installing collected packages: blessings 17:56:22 INFO - Running setup.py install for blessings 17:56:22 INFO - Successfully installed blessings 17:56:22 INFO - Cleaning up... 17:56:22 INFO - Return code: 0 17:56:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:23 INFO - Reading from file tmpfile_stdout 17:56:23 INFO - Current package versions: 17:56:23 INFO - blessings == 1.5.1 17:56:23 INFO - blobuploader == 1.2.4 17:56:23 INFO - docopt == 0.6.1 17:56:23 INFO - manifestparser == 1.1 17:56:23 INFO - mozInstall == 1.12 17:56:23 INFO - mozcrash == 0.16 17:56:23 INFO - mozdebug == 0.1 17:56:23 INFO - mozdevice == 0.47 17:56:23 INFO - mozfile == 1.2 17:56:23 INFO - mozhttpd == 0.7 17:56:23 INFO - mozinfo == 0.9 17:56:23 INFO - mozleak == 0.1 17:56:23 INFO - mozlog == 3.0 17:56:23 INFO - moznetwork == 0.27 17:56:23 INFO - mozprocess == 0.22 17:56:23 INFO - mozprofile == 0.27 17:56:23 INFO - mozrunner == 6.11 17:56:23 INFO - mozscreenshot == 0.1 17:56:23 INFO - mozsystemmonitor == 0.0 17:56:23 INFO - moztest == 0.7 17:56:23 INFO - mozversion == 1.4 17:56:23 INFO - psutil == 3.1.1 17:56:23 INFO - requests == 1.2.3 17:56:23 INFO - wsgiref == 0.1.2 17:56:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 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 0x10e0d3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe911e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, '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.TN0XojT1CR/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.8fU8zLOqh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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 17:56:23 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 17:56:23 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 17:56:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:56:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:23 INFO - 'HOME': '/Users/cltbld', 17:56:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:23 INFO - 'LOGNAME': 'cltbld', 17:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:23 INFO - 'MOZ_NO_REMOTE': '1', 17:56:23 INFO - 'NO_EM_RESTART': '1', 17:56:23 INFO - 'PAGER': '/bin/cat', 17:56:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:23 INFO - 'PWD': '/builds/slave/test', 17:56:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:23 INFO - 'SHELL': '/bin/bash', 17:56:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:56:23 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:56:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:23 INFO - 'USER': 'cltbld', 17:56:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:23 INFO - 'XPC_FLAGS': '0x0', 17:56:23 INFO - 'XPC_SERVICE_NAME': '0', 17:56:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 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)) 17:56:23 INFO - Cleaning up... 17:56:23 INFO - Return code: 0 17:56:23 INFO - Running post-action listener: _resource_record_post_action 17:56:23 INFO - Running post-action listener: _start_resource_monitoring 17:56:23 INFO - Starting resource monitoring. 17:56:23 INFO - ##### 17:56:23 INFO - ##### Running install step. 17:56:23 INFO - ##### 17:56:23 INFO - Running pre-action listener: _resource_record_pre_action 17:56:23 INFO - Running main action method: install 17:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:23 INFO - Reading from file tmpfile_stdout 17:56:23 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:24 INFO - Reading from file tmpfile_stdout 17:56:24 INFO - Output received: 17:56:24 INFO - Usage: mozinstall [options] installer 17:56:24 INFO - Options: 17:56:24 INFO - -h, --help show this help message and exit 17:56:24 INFO - -d DEST, --destination=DEST 17:56:24 INFO - Directory to install application into. [default: 17:56:24 INFO - "/builds/slave/test"] 17:56:24 INFO - --app=APP Application being installed. [default: firefox] 17:56:24 INFO - mkdir: /builds/slave/test/build/application 17:56:24 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'] 17:56:24 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 17:57:00 INFO - Reading from file tmpfile_stdout 17:57:00 INFO - Output received: 17:57:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:57:00 INFO - Running post-action listener: _resource_record_post_action 17:57:00 INFO - ##### 17:57:00 INFO - ##### Running run-tests step. 17:57:00 INFO - ##### 17:57:00 INFO - Running pre-action listener: _resource_record_pre_action 17:57:00 INFO - Running main action method: run_tests 17:57:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:57:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:57:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:57:00 INFO - 2015-11-16 17:57:00.919 screenresolution[2317:74773] starting screenresolution argv=screenresolution get 17:57:00 INFO - 2015-11-16 17:57:00.922 screenresolution[2317:74773] Display 0: 1600x1200x32@60 17:57:00 INFO - 2015-11-16 17:57:00.929 screenresolution[2318:74775] starting screenresolution argv=screenresolution list 17:57:00 INFO - Available Modes on Display 0 17:57:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:57:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:57:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:57:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:57:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:57:01 INFO - Intel HD Graphics 3000: 17:57:01 INFO - Chipset Model: Intel HD Graphics 3000 17:57:01 INFO - Type: GPU 17:57:01 INFO - Bus: Built-In 17:57:01 INFO - VRAM (Total): 512 MB 17:57:01 INFO - VRAM (Dynamic, Max): 10 17:57:01 INFO - Vendor: Intel (0x8086) 17:57:01 INFO - Device ID: 0x0116 17:57:01 INFO - Revision ID: 0x0009 17:57:01 INFO - Displays: 17:57:01 INFO - Display: 17:57:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:57:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:57:01 INFO - Display Serial Number: 1600x1200 60 17:57:01 INFO - Main Display: Yes 17:57:01 INFO - Mirror: Off 17:57:01 INFO - Online: Yes 17:57:01 INFO - Rotation: Supported 17:57:01 INFO - Return code: 0 17:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:01 INFO - Python 2.7.3 17:57:01 INFO - Return code: 0 17:57:01 INFO - grabbing minidump binary from tooltool 17:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:01 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 0x10dff69f0>, '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 0x10dd56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfea8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:01 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 17:57:01 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 17:57:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:01 INFO - Return code: 0 17:57:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:57:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:57:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0044', '--webServer', 'localhost'] in /builds/slave/test/build 17:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0044 --webServer localhost 17:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TN0XojT1CR/Render', 17:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:01 INFO - 'HOME': '/Users/cltbld', 17:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:01 INFO - 'LOGNAME': 'cltbld', 17:57:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:01 INFO - 'MOZ_NO_REMOTE': '1', 17:57:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:01 INFO - 'NO_EM_RESTART': '1', 17:57:01 INFO - 'PAGER': '/bin/cat', 17:57:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:01 INFO - 'PWD': '/builds/slave/test', 17:57:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:01 INFO - 'SHELL': '/bin/bash', 17:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8fU8zLOqh2/Listeners', 17:57:01 INFO - 'TMPDIR': '/var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/', 17:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:01 INFO - 'USER': 'cltbld', 17:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:01 INFO - 'XPC_FLAGS': '0x0', 17:57:01 INFO - 'XPC_SERVICE_NAME': '0', 17:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0044', '--webServer', 'localhost'] with output_timeout 3600 17:57:01 INFO - mozversion INFO | application_buildid: 20151116154007 17:57:01 INFO - mozversion INFO | application_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 17:57:01 INFO - mozversion INFO | application_display_name: Nightly 17:57:01 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:01 INFO - mozversion INFO | application_name: Firefox 17:57:01 INFO - mozversion INFO | application_remotingname: firefox 17:57:01 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:57:01 INFO - mozversion INFO | application_vendor: Mozilla 17:57:01 INFO - mozversion INFO | application_version: 45.0a1 17:57:01 INFO - mozversion INFO | platform_buildid: 20151116154007 17:57:01 INFO - mozversion INFO | platform_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 17:57:01 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:57:01 INFO - mozversion INFO | platform_version: 45.0a1 17:57:01 INFO - 2015-11-16 17:57:01,532 DEBUG : using testdate: 1447725421 17:57:01 INFO - 2015-11-16 17:57:01,532 DEBUG : actual date: 1447725421 17:57:01 INFO - 2015-11-16 17:57:01,542 INFO : starting webserver on 'localhost:54331' 17:57:01 INFO - 2015-11-16 17:57:01,543 INFO : Starting test suite t-yosemite-r5-0044 17:57:01 INFO - 2015-11-16 17:57:01,543 INFO : Starting test dromaeo_css 17:57:01 INFO - 2015-11-16 17:57:01,543 DEBUG : operating with platform_type : mac_ 17:57:01 INFO - 2015-11-16 17:57:01,544 INFO : Initialising browser for dromaeo_css test... 17:57:01 INFO - 2015-11-16 17:57:01,558 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpoMz4i5/profile http://localhost:54331/getInfo.html 17:57:03 INFO - 2015-11-16 17:57:03,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:57:03 INFO - 2015-11-16 17:57:03,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:57:03 INFO - 2015-11-16 17:57:03,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:57:03 INFO - 2015-11-16 17:57:03,937 DEBUG : BROWSER_OUTPUT: __metrics 17:57:03 INFO - 2015-11-16 17:57:03,953 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:57:04 INFO - 2015-11-16 17:57:04,644 INFO : Browser initialized. 17:57:04 INFO - 2015-11-16 17:57:04,645 INFO : Running cycle 1/1 for dromaeo_css test... 17:57:04 INFO - 2015-11-16 17:57:04,645 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmpoMz4i5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:57:16 INFO - 2015-11-16 17:57:16,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 230252544 17:57:16 INFO - 2015-11-16 17:57:16,629 DEBUG : BROWSER_OUTPUT: 17:58:07 INFO - 2015-11-16 17:58:07,835 DEBUG : BROWSER_OUTPUT: 1447725487826 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:00:18 INFO - 2015-11-16 18:00:18,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54331/tests/dromaeo/cssquery-ext.html) 18:00:20 INFO - 2015-11-16 18:00:20,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 341008384 18:00:20 INFO - 2015-11-16 18:00:20,164 DEBUG : BROWSER_OUTPUT: 18:03:22 INFO - 2015-11-16 18:03:22,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-ext.html (next: http://localhost:54331/tests/dromaeo/cssquery-jquery.html) 18:03:23 INFO - 2015-11-16 18:03:23,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 360402944 18:03:23 INFO - 2015-11-16 18:03:23,406 DEBUG : BROWSER_OUTPUT: 18:06:25 INFO - 2015-11-16 18:06:25,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54331/tests/dromaeo/cssquery-mootools.html) 18:06:26 INFO - 2015-11-16 18:06:26,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 331935744 18:06:26 INFO - 2015-11-16 18:06:26,078 DEBUG : BROWSER_OUTPUT: 18:09:28 INFO - 2015-11-16 18:09:28,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54331/tests/dromaeo/cssquery-prototype.html) 18:09:28 INFO - 2015-11-16 18:09:28,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 319176704 18:09:28 INFO - 2015-11-16 18:09:28,713 DEBUG : BROWSER_OUTPUT: 18:12:31 INFO - 2015-11-16 18:12:31,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54331/tests/dromaeo/cssquery-yui.html) 18:12:32 INFO - 2015-11-16 18:12:32,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 318574592 18:12:32 INFO - 2015-11-16 18:12:32,554 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/dromaeo/cssquery-yui.html (next: http://localhost:54331/tests/dromaeo/cssquery-dojo.html) 18:15:35 INFO - 2015-11-16 18:15:35,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 373297152 18:15:35 INFO - 2015-11-16 18:15:35,413 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,413 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:15:35 INFO - 2015-11-16 18:15:35,413 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:15:35 INFO - 2015-11-16 18:15:35,413 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:15:35 INFO - 2015-11-16 18:15:35,414 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:15:35 INFO - 2015-11-16 18:15:35,414 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3097.8605962731676;3146.119086655736;3174.460341741904;3277.6558461361556;3307.8180700061494;5038.924416133761;5182.8704282392955;5232.581393488516;5273.18265668821;5308.362996440433;5121.385433747955;5158.871028224296;5213.113770658988;5248.527632513083;5296.25852380666;4827.710337379768;4873.610111191114;4911.8035278588995;4932.852014439554;4951.752412379366;4933.555979961803;5005.474425185358;5022.121128802463;5035.874103147414;5051.898962020758;4612.677112602119;4719.174144524694;4721.6458765592715;4953.1332016896895;4954.7274899880495;4899.755012249373;4920.778564964585;4938.4814594467425;4950.405951285833;4961.776720047606;4902.730349830758;4903.779329930162;4904.5831104356175;4916.115099282128;4936.827211047596;5025.246213068032;5065.848024559269;5142.280080788692;5146.588272938156;5193.272941788153;5501.972490137524;5511.063119269734;5513.283273174502;5519.227308176858;5552.250446189753;5526.613137080406;5548.55611551075;5553.72231388433;5576.275084239063;5578.219049333096;4868.269759536098;4907.779149938297;5006.123928312531;5013.1227035268685;5216.478352164791;5647.943520564824;5680.14797780328;5696.572757043238;5767.480926716616;5770.221020162225;5456.127019676912;5463.3717122530625;5467.699276539828;5473.863153421196;5482.122860342326;5408.567314614821;5429.755660995264;5544.390117087117;5545.057340252167;5608.46719561641;5294.100002999499;5299.973500132474;5310.283111779938;5357.678539287655;5457.426970168154;5286.577073834161;5301.496357845998;5314.4951229633125;5326.627136100436;5343.919841202385;4135.110951145518;4166.0834616384345;4222.092250166229;4231.957680423218;4252.91494170121;3710.461983012448;3734.7198960078103;3808.4858544096746;3836.558795738526;3869.7484663497344;5143.922841157386;5150.4334523202415;5156.613254005964;5164.25118357836;5172.767225474862;5414.593905457106;5523.6409633373705;5594.804181853697;5607.383187849333;5634.943650563524;4761.547652972962;4837.250226214942;4839.612830973514;4856.562909338177;5149.562287205555;4609.124266389443;4612.538746125428;4628.097520983376;4643.883902902455;4676;5381.19282107687;5410.567154627542;5426.620136590401;5445.564354851682;5543.307086614173;5445.428230035789;5509.449055094618;5516.475934786189;5528.419515950767;5598.86002849932;5681.659100453986;5727.8854422912145;5728.742206600629;5735.3977832327;5746.109353050284;5281.709505977208;5379.1393377059485;5533.114701647878;5564.944350556442;5567.610267281251;5342.065138600807;5406.594505412031;5415.052365836042;5440.646357986719;5451.945480545144;5257.4742525747115;5368.812091576776;5370.409254981871;5400.270963419888;5410.323709536308;5155.02054609623;5303;5386.730663466733;5399.568034557147;5461.071617825059;5162.561182299547;5287.339082614673;5289.047971365191;5309.017831701148;5337.359516858002;5396.21754845553;5461.5357694596405;5508.697021663847;5522.447755224606;5529.281193444826;5133.024725302181;5222.582193424593;5344.75948582307;5413.106837371947;5427.294451721409 18:15:35 INFO - 2015-11-16 18:15:35,414 DEBUG : BROWSER_OUTPUT: |1;ext.html;513.5301199402547;524.6091661712026;524.7848382163312;524.8005757812032;538.8598964269294;28713.569296460544;31186.53220201696;37570.436443453335;38598.61401385985;38660.033499162535;40071.59928400715;40683.79658101705;40770.184596308056;40895.795521022425;40902;7739.342155916754;8503.319734421262;8613.138686131368;8621.741347759576;8653.091425400336;7693.115291741437;10557.472126393688;10616.150707943385;10637.202209834293;10684.358938463678;10413.479326033668;10414.687559373231;10465.73835654111;10483.528241229164;10553.155747540217;8000.759977200693;8137.023557173118;10382.584696612126;10479.895201048006;10518.263721539533;10095.697129086138;10347.844782328271;10353.482325883675;10372.170226381946;10376.429296388696;38930.80534597309;39228;39243.215135697414;39275.21449570992;39321;2846;2912.7669786417036;2957.940841183186;3197.952030719541;3319.219983303946;26227;26677.599836002475;26692.33269168267;26854.194374168612;26911.730882691118;2060.5981833542464;2069.2343832781817;2150.35489353195;2157.827373810107;2234.8323875709225;267633;268556;269504;270379;270677;58965.41034589685;59107.40892591105;59278.11082833761;59280;59576.404235957954;61556.38443615596;61626.69186654038;61636.38363616396;62044;62082.68958655268;13981.510647127301;14328.355224014944;14397.136171829723;14419.279036048156;14421.42314307437;10551.525181366856;10587.84118238227;10604.575816967235;10613.204009699304;10615.150787936947;18955.826492156655;19379;19467.318643847397;19495.805041949683;19528.54887383326;7181.6409179540815;7433.553986760703;7491.288327608869;7501;7504.962475187589;867.5315329722006;874.2001069021901;901.3330135699536;915.8992510823804;929.1544694328129;27647;28469.145925622266;28816.158145249618;29633.239190102668;29908.55137172944;870.8693695945659;939.234523863063;941.1153515695224;1031.510032734445;1043.5043354406596;14417.567472975827;14701;14847.777283340758;14995.175265360293;15135.772963405558;287940;290529;290978;294964.6762363307;300212;52107.478925210264;53117;53287;53420.73289633605;53442.198367024524;1278.0797825565764;1289.4842063174806;1291.65125416139;1292.4184117147322;1293.5989843148654;23234;25694.87152564225;27028.32429189286;27268.31829204286;27421;44853.77573112114;45668;45867;45960.770196148806;46040.53959460362;192086;193092;194070;195547;197864;29284.853575731984;29512.704872950995;29664;29894.551581725857;29937.55093673553;40457;40835;41249;41354.379684305364;41612.37581436341;33485;33722.66277337195;34047.82976085104;34209.82895085509;34214.14464638404;33475.33049339048;33545.66454335425;33702.15744606405;33843.323133537684;33887.491687625195;34131;34464.31071378508;35328.29343413169;35356;35476;28801.135965921058;29170.854145729136;30482.542761858145;30669.8466507666;30685.386292273583;21444.142234310453;21964.780352196914;22016.559668806854;22651.546969060855;23653 18:15:35 INFO - 2015-11-16 18:15:35,414 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.95646609474693;318.0966056399824;322.77889645592785;323.1436692764175;324.0537630120048;9642.855357169648;9933.460313651378;11001.119910407158;16814.31856814318;17701.203445844934;9937.701868943943;10962.177836662262;11019.724506887333;11261.155413343991;11365.715857103576;4083.12212874232;4174.373843923413;4276.6792490563175;4279.33670281107;4312.1806856697285;3242.643309235982;3407.727381809449;4224.429701990238;4285.507166675841;4496.2581174106235;4444.511103778598;4464.861460327612;4478.261086920655;4487.775611219442;4492.3710680504755;4344.89137771555;4416.690831641787;4435.35687325336;4474.060447306069;4487.887802804923;3729.3287208302495;3732.104294969188;3732.8133593320226;3739.9626003739886;3753.680937120348;11659.06727461801;11887.167898247126;11931.701707457296;12024.158308918291;12175.147739658227;1683.402392150781;1705.7100292950104;1712.9314827406888;1720.8021077575988;1893.9961820235296;8994.460332380078;9095.090490950919;9222.584983675752;9245.075492450702;9378.624855005792;1399.825021872266;1481.9925900370538;1482.4811316039409;1494.4097081652687;1502.3314624991883;54200.45799542033;55848;56811.43188568144;56829.71585142089;57010.71494642583;6032.879342413127;6081.391860813972;6170.969145154246;6204.658743769046;6231.376862313823;7018.1929078155645;7031.226565077837;7035;7047.40097091753;7071.8939215911805;4984.8753781155765;5033.748312584356;5069.011542749128;5074.517920797518;5079.873003174876;5317.042932272228;5329;5342.0384330820825;5345.732713364394;5355.116405793001;2766.7094955029434;2788.762955148835;2789.121426750567;2800.7339302766204;2802.8738706758245;957.683964291782;976.9936964926137;985.2462865907586;1008.9495525223709;1045.7803861189084;364.28054592180234;406.92878746219293;425.20486689890106;435.7799311347749;443.7803287372707;10642.680719578426;10844.511996960156;11198.216124871344;11226.214165008534;11404.258723183133;424.43550078395657;436.1908659436699;436.49366734587727;442.7078128435217;455.49667617283086;5877.52979761618;6014.278286605548;6055.303640081447;6090;6122.510199184144;374806;378520;381398;385098;445794;67533.662331689;67805;69224.6538767303;70058.2994170062;70870;466.349442527672;474.5325854033774;475.04278878060734;476.09541870445736;476.62584870876196;10184.439855808001;10384.948075259575;10422.635207767691;10424.895751042393;10447.738806529593;32633;32906;33331.16672083121;33525.49711754277;33894.15264618306;44215.55784442114;44316.33525497056;44729.32906006347;44751.77624111858;44811.327830083224;5648.350439699323;5798.333191682842;5800.883982320245;5814.273215848019;5829.912551311649;10786.730331741455;10871.40207288575;10965.890341096487;11199.60801371948;11248.26886252391;8137.064237612751;8151.470154439942;8374.874376884474;8429.241368276884;8985.371024028516;8578;9143.725688229364;9224.446533208029;9385.38994965325;9412.67055653049;9422.811543768948;9537.332386732862;9661.372010819274;9717.80564388694;9746.561404736945;5676.978143934131;5800.24596802413;5873.647581145145;5886.117082437669;5903.881922361443;9461.716148515556;9557.474338911148;9743.853842192515;9793.85309220348;9801.264905132286 18:15:35 INFO - 2015-11-16 18:15:35,415 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1167.7372591166984;1316.091896591352;1376.6214291069955;1474.7492926202544;1716.4164184177384;6766.221884483286;7229.349358557735;7535.472516923811;7719.073711154655;7740.032495938008;7502.662380192891;7542.6228688565625;7674.46278760487;7684.884726729089;7707.730229441971;1873.8032506586817;1906.332783525762;2124.2458927080897;2138.700581918533;2147.6885851551515;2146.64580344243;2177.357679484548;2185.9234926777567;2198.1317379635034;2199.098369668436;2068.1934045722182;2104.515961328895;2122.352682431858;2125.38363874477;2127.2767259131892;1901.2870173684869;1958.1482055305987;2066.5866826634733;2098.7376577927757;2108.5045014421753;2092.393205970267;2100.4853810816294;2110.683397490389;2111.0078263216265;2112.3134981131193;7602.54384736912;7676.7313144040245;7733.535987840692;7772.106207786121;7801.4929029612895;4546.477155127137;4685.812567497296;4689.132510485571;4691.695039822401;4693.88265293367;2678.9196324110308;2684.952868381333;2730.7678847298002;2772.9722702772915;2777.5833624956217;809.6154326694832;811.7037281392309;822.5434883639577;832.142892820396;833.1460253240416;10350.275480716353;10351.534180961875;10355.326903751233;10391.948040259751;10414.3751374917;4103.9179216416105;4142.79286035697;4224.66202703783;4304.397384366192;4329.913401732011;8896.377253592316;8932.598033088527;8942.150495702897;8953.149450802164;8957.14907083839;4653.069386122789;4682.227432473672;4684.508126646721;4684.601808846286;4684.882877928079;4217.472815898012;4229.0273237155625;4243.830246790094;4256.957430425656;4266.104118135227;3584.175639602906;3611.494390785292;3620.4931309616672;3641.362761516724;3677.8344974476213;1149.4424161140535;1151.6026970695098;1155.185594156118;1181.6336935550007;1190.6070996571111;1210;1216.7444836584416;1238.0961897814645;1242.018805143926;1246.7755803955374;7136.179339375934;7169.6773645186095;7184.209736928934;7189.604571748604;7191.424686025105;432.67765514691126;440.58144762475774;458.54145854145855;462.613717545853;462.81256091283086;5532.917006244909;5590;5608.6073974821375;5620.353659329147;5623.381428042912;8877.245434138042;8912.955435222782;8932.910670893209;8974.86537701935;9058.048904865025;8905.73282801517;8913;8915.331350148635;8939.73180804577;8943.016268210491;6876.106106206161;7061;7080.398166155832;7108.395786358217;7160.06919100524;6998.6150761708595;7032.718691252498;7059.71761129549;7063.328983746535;7089.397401220954;7830.765077047698;7870.488418252795;7938.56337901421;8018.83962320762;8038.67845286182;7975.441719079608;8134.511929284262;8263.256306932164;8293.377996650155;8317.126701696236;6238.282597501346;6527.51043671717;6590.670466476561;6636.800895972935;6726.663666816542;7131.144262688303;7146.249643787328;7196.820079498055;7198.244184360567;7238.02286691311;6622.8344291393105;6671.132752742113;6682.431993280626;6807.353301436356;6823.078884350549;5647.971760141338;6078.118672792509;6531.836704082436;6652.135222421054;6776.322367763184;6828.317168283132;6830.282820303796;6845.041694162722;6852.486063545154;6898.517103802686;6143.047827586553;6165.445109940127;6183.876322473436;6191.25704915413;6208.9689551551955;6157.32269450369;6337.081123237197;6362.172917520693;6378.1070650108095;6380.489560835215 18:15:35 INFO - 2015-11-16 18:15:35,417 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.80252835656825;305.8638905686969;309.82030422355035;312.31602789890144;312.4251377465463;5918.201042859213;5945.04879219325;6003.489703375219;6011.789587364443;6090.23872015998;5680.375158732547;5859.619124756888;5910.9113363299475;5955.136505206742;6017.909731354022;4592;4648.883777905546;4649.58153766161;4650.581447669709;4672.345871577982;4491.25894227452;4587.747673877935;4588.655850811186;4658.510856360084;4689.835855745049;4526.936170000047;4593.127305811901;4620.330052142437;4641.814327426916;4665.346851440801;4604.148232576984;4620.283856002325;4632.837850675244;4654.511276315972;4676.064787042571;3979.422983667381;3982.064214909523;3998.04047028711;3999.340108882031;4003.83984640614;5691.7723291068305;5781.710914454303;5842.5618078644275;5863.8534036649;5876.559258055663;5170.793168273264;5175.068487672217;5180.8445746627285;5182.870428239286;5183.041137389558;6287.182666253403;6292;6306;6310.968445157745;6328.905066424008;4279.40088387626;4286.271333873218;4299.333603291495;4302.010537576343;4309.655227581786;6349.4602958748565;6577.408033277028;6598.736050557924;6610.636414997173;6634.336566343423;4356.194104090753;4369;4371.475422949266;4385.035292235703;4402.207602631557;4419.779011049434;4441;4443.089166720879;4490.101979604092;4497.2804351304285;5034.144195486776;5138.177891537336;5165.225216217597;5173.922391164136;5175.767090480937;6280.340564240689;6317.747290108436;6324.9051264231075;6340.619562826245;6353.5234857385885;1564.984350156484;1569.395782623698;1582.4698725926944;1587.2936593162397;1595.2661775583363;1018.251585084962;1035.2184101003695;1038.3925403638955;1044.9111825494765;1047.4186826311318;5735.885282294331;5982.192404025488;5982.820515384546;6003.699815009232;6017.699115044318;6381.776637817654;6513.73945042193;6525.3474652535315;6542.149520562297;6548.6725663716625;5908.202392676933;6004.489618382399;6029.728662210124;6066.423689749467;6073.787417440457;3531.0466174133353;3561.252137051248;3568.197155640012;3578.5526809148855;3581.8209089545417;6675.732970681119;6774.491913106438;6794.218664853605;6805.523613347117;6806.217285012188;6815;6830.624315662587;6836.658167091626;6837.179538455417;6853.566983720807;6782.389584937379;6782.525223234326;6794.490413219029;6809.353111454305;6828.897566536506;6425.1968503937005;6638.47315117516;6640.933590664032;6642.269350371552;6679.432248258952;6449.871002579828;6508.153939987771;6509.772157974448;6522.271598026622;6564.179477565304;6767.560108592926;6787.762428314985;6797;6804.4216241620015;6810.931890681228;4119.134981653886;4439.667024973204;4444.155610434007;4448.7108337957925;4456.264716321771;6572.34276572339;6588.110605068255;6602;6616.735330586723;6623.735050597922;6396.936030639634;6406.263279722892;6408.455281301141;6410.647414392067;6415.294317625151;6186.381361863778;6348.365163483615;6390.13733146038;6404.647744374104;6421.678916054272;6243.906341404973;6245.937540624535;6246.500279977682;6252.687365631609;6253.7185826637;6303.873922521616;6338.112664227104;6359.523035772429;6376.330485298977;6415.101885736094;6040.486558642565;6094.542909281733;6238.812835614939;6251.562390632612;6275.278342990615 18:15:35 INFO - 2015-11-16 18:15:35,420 DEBUG : BROWSER_OUTPUT: |5;yui.html;725.0538047847557;725.836686745482;731.6926890705903;747.6336595068417;785.9646315915783;12832.935835320823;13038.869611303884;13042.413091410874;13054.543090991818;13085.60743177705;12127.332996685202;12220.694482637939;13481.865181348208;13483.12359696619;13657.248851313174;645.4707140145083;651.8533330000736;813.1299509524811;825.2613910550054;826.962786674601;817.9550124743137;821.8068753842842;821.9589020548949;830.2818062376061;833.6707000734706;860.5310105992218;862.2713806833216;864.3042350907517;864.7967727584013;865.5628907401754;687.549654975989;698.3016983016983;845.0915266088979;857.8327226190864;863.6415887406719;627.4980015987237;628.0798630007016;630.6247782569363;631.9146915166485;632.5161251642497;12744.745105097845;12866.806997895039;12870.871291287061;12914.354282285942;12993.220406775623;8696.652133914637;8784.341174411944;8937.240334571568;9121;9196.356255062148;8256.545889976049;8366.53984030878;8382.16178382163;8585.01272353681;8599.742007739715;2803.915882523507;2845.075350511092;2845.2886778305424;2862.169970708492;2899.666538348075;41262.38106428406;41760.58239417597;42080;42101.1579768406;42184.156316873494;5348.331458567679;5379.946200537945;5401.081816091274;5424.620276580601;5608.355039170548;10548.789024219474;10549.525271362807;10587.735306617396;10616.787664246673;10624.946875265574;5345.518903298722;5401.378841433286;5477.45225477457;5477.835664930059;5608.691521966331;3589.7564022485944;3647.0517665407187;3656.689181419556;3722.590515043343;3755.75587586806;2434.5252675728416;2465.4083020075054;2471.9629205561932;2480.057578120339;2484.1181380609983;362.4780316344508;364.67726062434406;377.63935441653706;378.30392078575005;378.6705566157461;520.5601266929514;538.9811356602501;545.5117669685609;579.7536047180016;579.9188113664006;7912.208779122042;7998.280154786097;8226.753197404087;8247.628856701464;8381.874271885927;456.49329244538535;491.3440556856565;575.4102045403495;589.6167491130799;602.728772052578;3478.669526394988;3506.579210494757;3705.2959937611768;3712.579594181092;3730.0301921500063;56643.71678141665;57811.42188578145;58057.4194258052;58154.4184558149;58818.70590647105;49529.752351238734;50431.49568504342;50789.746051270246;50929;50997.235041473665;44437.33343999842;44969.775151124035;45328.3200751989;46363.30455043177;46625.766871165426;7124.145102587722;7158.534695244793;7187.7843664690145;7201.207867134715;7383.815404614713;33534.49698254479;34028;34317;34382.65617343794;34973.47539786956;41892.79053604713;44810.55189448064;45472;46504.7674761624;46508.30237546507;6787.966060169668;6806.719748884179;6934.306569343227;7061.611611361424;7312.305330993547;9656.32405731592;9728.902710973083;9912.653057142965;10240.53917573696;10255.94872025635;9276.814463710823;9429.894285032888;9431.57557909882;9438.716838494582;9463.242940564876;9097.317701172306;9474.85787713171;9557.713268601952;9899;9966.103050725469;8563.914360856312;8607.48355098696;8831.69089081879;9151.816963660822;9376.578053987723;8440.788980275542;8501.659933602587;8502.14978502145;8711.21599056088;8835.823283534422;7053.259407762111;8267.751967440987;8692.913070869463;8957;9061.09389061115 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,969 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: __startTimestamp1447726535406__endTimestamp 18:15:35 INFO - 2015-11-16 18:15:35,421 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,422 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:15:35 INFO - 2015-11-16 18:15:35,422 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:15:35 INFO - 2015-11-16 18:15:35,422 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,422 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5129.29 Median:5294.10 stddev:535.13 (10.1%) stddev-sans-first:512.50 18:15:35 INFO - 2015-11-16 18:15:35,422 DEBUG : BROWSER_OUTPUT: Values: 3097.9 3146.1 3174.5 3277.7 3307.8 5038.9 5182.9 5232.6 5273.2 5308.4 5121.4 5158.9 5213.1 5248.5 5296.3 4827.7 4873.6 4911.8 4932.9 4951.8 4933.6 5005.5 5022.1 5035.9 5051.9 4612.7 4719.2 4721.6 4953.1 4954.7 4899.8 4920.8 4938.5 4950.4 4961.8 4902.7 4903.8 4904.6 4916.1 4936.8 5025.2 5065.8 5142.3 5146.6 5193.3 5502.0 5511.1 5513.3 5519.2 5552.3 5526.6 5548.6 5553.7 5576.3 5578.2 4868.3 4907.8 5006.1 5013.1 5216.5 5647.9 5680.1 5696.6 5767.5 5770.2 5456.1 5463.4 5467.7 5473.9 5482.1 5408.6 5429.8 5544.4 5545.1 5608.5 5294.1 5300.0 5310.3 5357.7 5457.4 5286.6 5301.5 5314.5 5326.6 5343.9 4135.1 4166.1 4222.1 4232.0 4252.9 3710.5 3734.7 3808.5 3836.6 3869.7 5143.9 5150.4 5156.6 5164.3 5172.8 5414.6 5523.6 5594.8 5607.4 5634.9 4761.5 4837.3 4839.6 4856.6 5149.6 4609.1 4612.5 4628.1 4643.9 4676.0 5381.2 5410.6 5426.6 5445.6 5543.3 5445.4 5509.4 5516.5 5528.4 5598.9 5681.7 5727.9 5728.7 5735.4 5746.1 5281.7 5379.1 5533.1 5564.9 5567.6 5342.1 5406.6 5415.1 5440.6 5451.9 5257.5 5368.8 5370.4 5400.3 5410.3 5155.0 5303.0 5386.7 5399.6 5461.1 5162.6 5287.3 5289.0 5309.0 5337.4 5396.2 5461.5 5508.7 5522.4 5529.3 5133.0 5222.6 5344.8 5413.1 5427.3 18:15:35 INFO - 2015-11-16 18:15:35,423 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,423 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42301.54 Median:29779.28 stddev:66776.42 (224.2%) stddev-sans-first:66890.03 18:15:35 INFO - 2015-11-16 18:15:35,423 DEBUG : BROWSER_OUTPUT: Values: 513.5 524.6 524.8 524.8 538.9 28713.6 31186.5 37570.4 38598.6 38660.0 40071.6 40683.8 40770.2 40895.8 40902.0 7739.3 8503.3 8613.1 8621.7 8653.1 7693.1 10557.5 10616.2 10637.2 10684.4 10413.5 10414.7 10465.7 10483.5 10553.2 8000.8 8137.0 10382.6 10479.9 10518.3 10095.7 10347.8 10353.5 10372.2 10376.4 38930.8 39228.0 39243.2 39275.2 39321.0 2846.0 2912.8 2957.9 3198.0 3319.2 26227.0 26677.6 26692.3 26854.2 26911.7 2060.6 2069.2 2150.4 2157.8 2234.8 267633.0 268556.0 269504.0 270379.0 270677.0 58965.4 59107.4 59278.1 59280.0 59576.4 61556.4 61626.7 61636.4 62044.0 62082.7 13981.5 14328.4 14397.1 14419.3 14421.4 10551.5 10587.8 10604.6 10613.2 10615.2 18955.8 19379.0 19467.3 19495.8 19528.5 7181.6 7433.6 7491.3 7501.0 7505.0 867.5 874.2 901.3 915.9 929.2 27647.0 28469.1 28816.2 29633.2 29908.6 870.9 939.2 941.1 1031.5 1043.5 14417.6 14701.0 14847.8 14995.2 15135.8 287940.0 290529.0 290978.0 294964.7 300212.0 52107.5 53117.0 53287.0 53420.7 53442.2 1278.1 1289.5 1291.7 1292.4 1293.6 23234.0 25694.9 27028.3 27268.3 27421.0 44853.8 45668.0 45867.0 45960.8 46040.5 192086.0 193092.0 194070.0 195547.0 197864.0 29284.9 29512.7 29664.0 29894.6 29937.6 40457.0 40835.0 41249.0 41354.4 41612.4 33485.0 33722.7 34047.8 34209.8 34214.1 33475.3 33545.7 33702.2 33843.3 33887.5 34131.0 34464.3 35328.3 35356.0 35476.0 28801.1 29170.9 30482.5 30669.8 30685.4 21444.1 21964.8 22016.6 22651.5 23653.0 18:15:35 INFO - 2015-11-16 18:15:35,423 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,423 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21699.88 Median:24612.92 stddev:64920.98 (263.8%) stddev-sans-first:65083.23 18:15:35 INFO - 2015-11-16 18:15:35,425 DEBUG : BROWSER_OUTPUT: Values: 311.0 318.1 322.8 323.1 324.1 9642.9 9933.5 11001.1 16814.3 17701.2 9937.7 10962.2 11019.7 11261.2 11365.7 4083.1 4174.4 4276.7 4279.3 4312.2 3242.6 3407.7 4224.4 4285.5 4496.3 4444.5 4464.9 4478.3 4487.8 4492.4 4344.9 4416.7 4435.4 4474.1 4487.9 3729.3 3732.1 3732.8 3740.0 3753.7 11659.1 11887.2 11931.7 12024.2 12175.1 1683.4 1705.7 1712.9 1720.8 1894.0 8994.5 9095.1 9222.6 9245.1 9378.6 1399.8 1482.0 1482.5 1494.4 1502.3 54200.5 55848.0 56811.4 56829.7 57010.7 6032.9 6081.4 6171.0 6204.7 6231.4 7018.2 7031.2 7035.0 7047.4 7071.9 4984.9 5033.7 5069.0 5074.5 5079.9 5317.0 5329.0 5342.0 5345.7 5355.1 2766.7 2788.8 2789.1 2800.7 2802.9 957.7 977.0 985.2 1008.9 1045.8 364.3 406.9 425.2 435.8 443.8 10642.7 10844.5 11198.2 11226.2 11404.3 424.4 436.2 436.5 442.7 455.5 5877.5 6014.3 6055.3 6090.0 6122.5 374806.0 378520.0 381398.0 385098.0 445794.0 67533.7 67805.0 69224.7 70058.3 70870.0 466.3 474.5 475.0 476.1 476.6 10184.4 10384.9 10422.6 10424.9 10447.7 32633.0 32906.0 33331.2 33525.5 33894.2 44215.6 44316.3 44729.3 44751.8 44811.3 5648.4 5798.3 5800.9 5814.3 5829.9 10786.7 10871.4 10965.9 11199.6 11248.3 8137.1 8151.5 8374.9 8429.2 8985.4 8578.0 9143.7 9224.4 9385.4 9412.7 9422.8 9537.3 9661.4 9717.8 9746.6 5677.0 5800.2 5873.6 5886.1 5903.9 9461.7 9557.5 9743.9 9793.9 9801.3 18:15:35 INFO - 2015-11-16 18:15:35,425 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,425 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5243.62 Median:6187.57 stddev:2772.67 (44.8%) stddev-sans-first:2763.52 18:15:35 INFO - 2015-11-16 18:15:35,426 DEBUG : BROWSER_OUTPUT: Values: 1167.7 1316.1 1376.6 1474.7 1716.4 6766.2 7229.3 7535.5 7719.1 7740.0 7502.7 7542.6 7674.5 7684.9 7707.7 1873.8 1906.3 2124.2 2138.7 2147.7 2146.6 2177.4 2185.9 2198.1 2199.1 2068.2 2104.5 2122.4 2125.4 2127.3 1901.3 1958.1 2066.6 2098.7 2108.5 2092.4 2100.5 2110.7 2111.0 2112.3 7602.5 7676.7 7733.5 7772.1 7801.5 4546.5 4685.8 4689.1 4691.7 4693.9 2678.9 2685.0 2730.8 2773.0 2777.6 809.6 811.7 822.5 832.1 833.1 10350.3 10351.5 10355.3 10391.9 10414.4 4103.9 4142.8 4224.7 4304.4 4329.9 8896.4 8932.6 8942.2 8953.1 8957.1 4653.1 4682.2 4684.5 4684.6 4684.9 4217.5 4229.0 4243.8 4257.0 4266.1 3584.2 3611.5 3620.5 3641.4 3677.8 1149.4 1151.6 1155.2 1181.6 1190.6 1210.0 1216.7 1238.1 1242.0 1246.8 7136.2 7169.7 7184.2 7189.6 7191.4 432.7 440.6 458.5 462.6 462.8 5532.9 5590.0 5608.6 5620.4 5623.4 8877.2 8913.0 8932.9 8974.9 9058.0 8905.7 8913.0 8915.3 8939.7 8943.0 6876.1 7061.0 7080.4 7108.4 7160.1 6998.6 7032.7 7059.7 7063.3 7089.4 7830.8 7870.5 7938.6 8018.8 8038.7 7975.4 8134.5 8263.3 8293.4 8317.1 6238.3 6527.5 6590.7 6636.8 6726.7 7131.1 7146.2 7196.8 7198.2 7238.0 6622.8 6671.1 6682.4 6807.4 6823.1 5648.0 6078.1 6531.8 6652.1 6776.3 6828.3 6830.3 6845.0 6852.5 6898.5 6143.0 6165.4 6183.9 6191.3 6209.0 6157.3 6337.1 6362.2 6378.1 6380.5 18:15:35 INFO - 2015-11-16 18:15:35,427 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,427 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5294.43 Median:6003.59 stddev:1612.81 (26.9%) stddev-sans-first:1573.24 18:15:35 INFO - 2015-11-16 18:15:35,427 DEBUG : BROWSER_OUTPUT: Values: 303.8 305.9 309.8 312.3 312.4 5918.2 5945.0 6003.5 6011.8 6090.2 5680.4 5859.6 5910.9 5955.1 6017.9 4592.0 4648.9 4649.6 4650.6 4672.3 4491.3 4587.7 4588.7 4658.5 4689.8 4526.9 4593.1 4620.3 4641.8 4665.3 4604.1 4620.3 4632.8 4654.5 4676.1 3979.4 3982.1 3998.0 3999.3 4003.8 5691.8 5781.7 5842.6 5863.9 5876.6 5170.8 5175.1 5180.8 5182.9 5183.0 6287.2 6292.0 6306.0 6311.0 6328.9 4279.4 4286.3 4299.3 4302.0 4309.7 6349.5 6577.4 6598.7 6610.6 6634.3 4356.2 4369.0 4371.5 4385.0 4402.2 4419.8 4441.0 4443.1 4490.1 4497.3 5034.1 5138.2 5165.2 5173.9 5175.8 6280.3 6317.7 6324.9 6340.6 6353.5 1565.0 1569.4 1582.5 1587.3 1595.3 1018.3 1035.2 1038.4 1044.9 1047.4 5735.9 5982.2 5982.8 6003.7 6017.7 6381.8 6513.7 6525.3 6542.1 6548.7 5908.2 6004.5 6029.7 6066.4 6073.8 3531.0 3561.3 3568.2 3578.6 3581.8 6675.7 6774.5 6794.2 6805.5 6806.2 6815.0 6830.6 6836.7 6837.2 6853.6 6782.4 6782.5 6794.5 6809.4 6828.9 6425.2 6638.5 6640.9 6642.3 6679.4 6449.9 6508.2 6509.8 6522.3 6564.2 6767.6 6787.8 6797.0 6804.4 6810.9 4119.1 4439.7 4444.2 4448.7 4456.3 6572.3 6588.1 6602.0 6616.7 6623.7 6396.9 6406.3 6408.5 6410.6 6415.3 6186.4 6348.4 6390.1 6404.6 6421.7 6243.9 6245.9 6246.5 6252.7 6253.7 6303.9 6338.1 6359.5 6376.3 6415.1 6040.5 6094.5 6238.8 6251.6 6275.3 18:15:35 INFO - 2015-11-16 18:15:35,427 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2015-11-16 18:15:35,428 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12466.75 Median:579.84 stddev:15757.47 (2717.6%) stddev-sans-first:15777.01 18:15:35 INFO - 2015-11-16 18:15:35,428 DEBUG : BROWSER_OUTPUT: Values: 725.1 725.8 731.7 747.6 786.0 12832.9 13038.9 13042.4 13054.5 13085.6 12127.3 12220.7 13481.9 13483.1 13657.2 645.5 651.9 813.1 825.3 827.0 818.0 821.8 822.0 830.3 833.7 860.5 862.3 864.3 864.8 865.6 687.5 698.3 845.1 857.8 863.6 627.5 628.1 630.6 631.9 632.5 12744.7 12866.8 12870.9 12914.4 12993.2 8696.7 8784.3 8937.2 9121.0 9196.4 8256.5 8366.5 8382.2 8585.0 8599.7 2803.9 2845.1 2845.3 2862.2 2899.7 41262.4 41760.6 42080.0 42101.2 42184.2 5348.3 5379.9 5401.1 5424.6 5608.4 10548.8 10549.5 10587.7 10616.8 10624.9 5345.5 5401.4 5477.5 5477.8 5608.7 3589.8 3647.1 3656.7 3722.6 3755.8 2434.5 2465.4 2472.0 2480.1 2484.1 362.5 364.7 377.6 378.3 378.7 520.6 539.0 545.5 579.8 579.9 7912.2 7998.3 8226.8 8247.6 8381.9 456.5 491.3 575.4 589.6 602.7 3478.7 3506.6 3705.3 3712.6 3730.0 56643.7 57811.4 58057.4 58154.4 58818.7 49529.8 50431.5 50789.7 50929.0 50997.2 44437.3 44969.8 45328.3 46363.3 46625.8 7124.1 7158.5 7187.8 7201.2 7383.8 33534.5 34028.0 34317.0 34382.7 34973.5 41892.8 44810.6 45472.0 46504.8 46508.3 6788.0 6806.7 6934.3 7061.6 7312.3 9656.3 9728.9 9912.7 10240.5 10255.9 9276.8 9429.9 9431.6 9438.7 9463.2 9097.3 9474.9 9557.7 9899.0 9966.1 8563.9 8607.5 8831.7 9151.8 9376.6 8440.8 8501.7 8502.1 8711.2 8835.8 7053.3 8267.8 8692.9 8957.0 9061.1 18:15:35 INFO - 2015-11-16 18:15:35,429 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:15:35 INFO - 2015-11-16 18:15:35,429 DEBUG : BROWSER_OUTPUT: 18:15:36 INFO - 2015-11-16 18:15:36,120 INFO : Browser exited with error code: 0 18:15:36 INFO - 2015-11-16 18:15:36,148 INFO : Completed test dromaeo_css (00:18:34) 18:15:36 INFO - 2015-11-16 18:15:36,148 INFO : Starting test kraken 18:15:36 INFO - 2015-11-16 18:15:36,148 DEBUG : operating with platform_type : mac_ 18:15:36 INFO - 2015-11-16 18:15:36,148 INFO : Initialising browser for kraken test... 18:15:36 INFO - 2015-11-16 18:15:36,161 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmp3Fg2gm/profile http://localhost:54331/getInfo.html 18:15:38 INFO - 2015-11-16 18:15:38,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:15:38 INFO - 2015-11-16 18:15:38,480 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:15:38 INFO - 2015-11-16 18:15:38,481 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:15:38 INFO - 2015-11-16 18:15:38,481 DEBUG : BROWSER_OUTPUT: __metrics 18:15:38 INFO - 2015-11-16 18:15:38,497 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:15:39 INFO - 2015-11-16 18:15:39,170 INFO : Browser initialized. 18:15:39 INFO - 2015-11-16 18:15:39,171 INFO : Running cycle 1/1 for kraken test... 18:15:39 INFO - 2015-11-16 18:15:39,171 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmp3Fg2gm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:15:51 INFO - 2015-11-16 18:15:51,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 228982784 18:15:51 INFO - 2015-11-16 18:15:51,160 DEBUG : BROWSER_OUTPUT: 18:15:53 INFO - 2015-11-16 18:15:53,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54331/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:54 INFO - 2015-11-16 18:15:54,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 286040064 18:15:54 INFO - 2015-11-16 18:15:54,262 DEBUG : BROWSER_OUTPUT: 18:15:56 INFO - 2015-11-16 18:15:56,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54331/tests/kraken/driver.html?testName=audio-dft) 18:15:57 INFO - 2015-11-16 18:15:57,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 298065920 18:15:57 INFO - 2015-11-16 18:15:57,525 DEBUG : BROWSER_OUTPUT: 18:16:00 INFO - 2015-11-16 18:16:00,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54331/tests/kraken/driver.html?testName=audio-fft) 18:16:01 INFO - 2015-11-16 18:16:01,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 282959872 18:16:01 INFO - 2015-11-16 18:16:01,151 DEBUG : BROWSER_OUTPUT: 18:16:03 INFO - 2015-11-16 18:16:03,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54331/tests/kraken/driver.html?testName=audio-oscillator) 18:16:03 INFO - 2015-11-16 18:16:03,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 283869184 18:16:03 INFO - 2015-11-16 18:16:03,789 DEBUG : BROWSER_OUTPUT: 18:16:06 INFO - 2015-11-16 18:16:06,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:06 INFO - 2015-11-16 18:16:06,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 283877376 18:16:06 INFO - 2015-11-16 18:16:06,591 DEBUG : BROWSER_OUTPUT: 18:16:09 INFO - 2015-11-16 18:16:09,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54331/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:10 INFO - 2015-11-16 18:16:10,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 284139520 18:16:10 INFO - 2015-11-16 18:16:10,322 DEBUG : BROWSER_OUTPUT: 18:16:13 INFO - 2015-11-16 18:16:13,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54331/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:14 INFO - 2015-11-16 18:16:14,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 286695424 18:16:14 INFO - 2015-11-16 18:16:14,156 DEBUG : BROWSER_OUTPUT: 18:16:17 INFO - 2015-11-16 18:16:17,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54331/tests/kraken/driver.html?testName=json-parse-financial) 18:16:17 INFO - 2015-11-16 18:16:17,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 286097408 18:16:17 INFO - 2015-11-16 18:16:17,666 DEBUG : BROWSER_OUTPUT: 18:16:19 INFO - 2015-11-16 18:16:19,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:19 INFO - 2015-11-16 18:16:19,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 317091840 18:16:19 INFO - 2015-11-16 18:16:19,834 DEBUG : BROWSER_OUTPUT: 18:16:21 INFO - 2015-11-16 18:16:21,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:22 INFO - 2015-11-16 18:16:22,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 318533632 18:16:22 INFO - 2015-11-16 18:16:22,315 DEBUG : BROWSER_OUTPUT: 18:16:24 INFO - 2015-11-16 18:16:24,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:25 INFO - 2015-11-16 18:16:25,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 327860224 18:16:25 INFO - 2015-11-16 18:16:25,038 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2015-11-16 18:16:27,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:28 INFO - 2015-11-16 18:16:28,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 330358784 18:16:28 INFO - 2015-11-16 18:16:28,334 DEBUG : BROWSER_OUTPUT: 18:16:31 INFO - 2015-11-16 18:16:31,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:31 INFO - 2015-11-16 18:16:31,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 329879552 18:16:31 INFO - 2015-11-16 18:16:31,586 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54331/tests/kraken/driver.html?testName=ai-astar) 18:16:33 INFO - 2015-11-16 18:16:33,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 387866624 18:16:33 INFO - 2015-11-16 18:16:33,595 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,595 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:16:33 INFO - 2015-11-16 18:16:33,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |0;ai-astar;104;105;102;106;106;107;98;105;109;107 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;134;152;165;126;152;151;132;168;130 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;163;168;173;175;171;168;174 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;83;87;86;69;72;77;87;89;88 18:16:33 INFO - 2015-11-16 18:16:33,597 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;102;139;89;90;94;132;95;95;135 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;123;121;114;121;130;129;121;118;123;129 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;125;126;136;136;135;130;135;135;136 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;98;103;100;100;100;110;109;109;108 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;59;59;59;59;60;65;69;62;60 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;70;71;73;72;73;74 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;88;85;87;90;92;91;95;95;93 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;124;143;143;138;150;145;137;131;137 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;143;158;156;166;151;164;164;158;146 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;69;71;72;75;73;74;75;75 18:16:33 INFO - 2015-11-16 18:16:33,598 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:16:33 INFO - 2015-11-16 18:16:33,599 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:16:33 INFO - 2015-11-16 18:16:33,599 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 18:16:33 INFO - 2015-11-16 18:16:33,599 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:16:33 INFO - 2015-11-16 18:16:33,599 DEBUG : BROWSER_OUTPUT: __startTimestamp1447726593594__endTimestamp 18:16:33 INFO - 2015-11-16 18:16:33,599 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,600 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:16:33 INFO - 2015-11-16 18:16:33,600 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:16:33 INFO - 2015-11-16 18:16:33,600 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:104.90 Median:106.50 stddev:3.07 (2.9%) stddev-sans-first:3.24 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: Values: 104.0 105.0 102.0 106.0 106.0 107.0 98.0 105.0 109.0 107.0 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:152.00 stddev:15.46 (10.2%) stddev-sans-first:15.56 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: Values: 161.0 134.0 152.0 165.0 126.0 152.0 151.0 132.0 168.0 130.0 18:16:33 INFO - 2015-11-16 18:16:33,601 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,602 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.70 Median:169.50 stddev:5.42 (3.2%) stddev-sans-first:5.34 18:16:33 INFO - 2015-11-16 18:16:33,602 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 163.0 168.0 173.0 175.0 171.0 168.0 174.0 18:16:33 INFO - 2015-11-16 18:16:33,602 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,602 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:86.50 stddev:7.59 (8.8%) stddev-sans-first:7.47 18:16:33 INFO - 2015-11-16 18:16:33,602 DEBUG : BROWSER_OUTPUT: Values: 73.0 83.0 87.0 86.0 69.0 72.0 77.0 87.0 89.0 88.0 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:20.02 (21.8%) stddev-sans-first:20.98 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: Values: 98.0 102.0 139.0 89.0 90.0 94.0 132.0 95.0 95.0 135.0 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:122.90 Median:123.00 stddev:5.15 (4.2%) stddev-sans-first:5.46 18:16:33 INFO - 2015-11-16 18:16:33,603 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 114.0 121.0 130.0 129.0 121.0 118.0 123.0 129.0 18:16:33 INFO - 2015-11-16 18:16:33,604 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,604 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.10 Median:135.00 stddev:4.58 (3.4%) stddev-sans-first:4.47 18:16:33 INFO - 2015-11-16 18:16:33,604 DEBUG : BROWSER_OUTPUT: Values: 127.0 125.0 126.0 136.0 136.0 135.0 130.0 135.0 135.0 136.0 18:16:33 INFO - 2015-11-16 18:16:33,604 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:103.20 Median:109.00 stddev:5.39 (4.9%) stddev-sans-first:4.83 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: Values: 95.0 98.0 103.0 100.0 100.0 100.0 110.0 109.0 109.0 108.0 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.00 stddev:3.34 (5.5%) stddev-sans-first:3.50 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: Values: 63.0 59.0 59.0 59.0 59.0 60.0 65.0 69.0 62.0 60.0 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:2.02 (2.8%) stddev-sans-first:1.86 18:16:33 INFO - 2015-11-16 18:16:33,606 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 70.0 71.0 73.0 72.0 73.0 74.0 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:91.50 stddev:3.61 (4.0%) stddev-sans-first:3.50 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: Values: 86.0 88.0 85.0 87.0 90.0 92.0 91.0 95.0 95.0 93.0 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:140.50 stddev:7.50 (5.3%) stddev-sans-first:7.79 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: Values: 134.0 124.0 143.0 143.0 138.0 150.0 145.0 137.0 131.0 137.0 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:158.00 stddev:7.69 (4.9%) stddev-sans-first:8.14 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: Values: 158.0 143.0 158.0 156.0 166.0 151.0 164.0 164.0 158.0 146.0 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: 18:16:33 INFO - 2015-11-16 18:16:33,607 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.50 stddev:2.22 (3.0%) stddev-sans-first:2.29 18:16:33 INFO - 2015-11-16 18:16:33,608 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 71.0 72.0 75.0 73.0 74.0 75.0 75.0 18:16:33 INFO - 2015-11-16 18:16:33,608 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:16:33 INFO - 2015-11-16 18:16:33,608 DEBUG : BROWSER_OUTPUT: 18:16:34 INFO - 2015-11-16 18:16:34,269 INFO : Browser exited with error code: 0 18:16:34 INFO - 2015-11-16 18:16:34,320 INFO : Completed test kraken (00:00:58) 18:16:34 INFO - 2015-11-16 18:16:34,320 INFO : Starting test v8_7 18:16:34 INFO - 2015-11-16 18:16:34,321 DEBUG : operating with platform_type : mac_ 18:16:34 INFO - 2015-11-16 18:16:34,321 INFO : Initialising browser for v8_7 test... 18:16:34 INFO - 2015-11-16 18:16:34,339 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmprqVyjj/profile http://localhost:54331/getInfo.html 18:16:36 INFO - 2015-11-16 18:16:36,642 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:16:36 INFO - 2015-11-16 18:16:36,642 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:16:36 INFO - 2015-11-16 18:16:36,642 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:16:36 INFO - 2015-11-16 18:16:36,642 DEBUG : BROWSER_OUTPUT: __metrics 18:16:36 INFO - 2015-11-16 18:16:36,659 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:16:37 INFO - 2015-11-16 18:16:37,356 INFO : Browser initialized. 18:16:37 INFO - 2015-11-16 18:16:37,357 INFO : Running cycle 1/1 for v8_7 test... 18:16:37 INFO - 2015-11-16 18:16:37,357 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0m/98vh6mr96197mhwl86256q3000000w/T/tmprqVyjj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:16:49 INFO - 2015-11-16 18:16:49,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 229777408 18:16:49 INFO - 2015-11-16 18:16:49,340 DEBUG : BROWSER_OUTPUT: 18:17:10 INFO - 2015-11-16 18:17:10,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54331/tests/v8_7/run.html (next: http://localhost:54331/tests/v8_7/run.html) 18:17:11 INFO - 2015-11-16 18:17:11,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 688680960 18:17:11 INFO - 2015-11-16 18:17:11,120 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: |0;Richards;166.25103906899417 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 18:17:11 INFO - 2015-11-16 18:17:11,121 DEBUG : BROWSER_OUTPUT: |2;Encrypt;330.1419610432486 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5970.238095238095 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |5;Earley;1049.3179433368311 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |6;Boyer;14069.444444444445 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |7;RegExp;31343.75 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |8;Splay;645.1612903225806 18:17:11 INFO - 2015-11-16 18:17:11,122 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5982.142857142857 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1447726631114__endTimestamp 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,123 DEBUG : BROWSER_OUTPUT: Values: 166.3 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: Values: 194.3 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:330.14 Median:330.14 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,124 DEBUG : BROWSER_OUTPUT: Values: 330.1 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5970.24 Median:5970.24 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: Values: 5970.2 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: Values: 1990.1 18:17:11 INFO - 2015-11-16 18:17:11,125 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1049.32 Median:1049.32 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: Values: 1049.3 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14069.44 Median:14069.44 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: Values: 14069.4 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31343.75 Median:31343.75 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,126 DEBUG : BROWSER_OUTPUT: Values: 31343.8 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:645.16 Median:645.16 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: Values: 645.2 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5982.14 Median:5982.14 stddev:0.00 (0.0%) 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: Values: 5982.1 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:17:11 INFO - 2015-11-16 18:17:11,127 DEBUG : BROWSER_OUTPUT: 18:17:11 INFO - 2015-11-16 18:17:11,819 INFO : Browser exited with error code: 0 18:17:11 INFO - 2015-11-16 18:17:11,838 INFO : Completed test v8_7 (00:00:37) 18:17:12 INFO - 2015-11-16 18:17:12,158 INFO : Completed test suite (00:20:10) 18:17:12 INFO - 2015-11-16 18:17:12,158 DEBUG : Working with test: dromaeo_css 18:17:12 INFO - 2015-11-16 18:17:12,158 DEBUG : Generating results file: dromaeo_css 18:17:12 INFO - 2015-11-16 18:17:12,158 DEBUG : Working with test: kraken 18:17:12 INFO - 2015-11-16 18:17:12,158 DEBUG : Generating results file: kraken 18:17:12 INFO - 2015-11-16 18:17:12,159 INFO : javascript benchmark 18:17:12 INFO - 2015-11-16 18:17:12,159 DEBUG : Working with test: v8_7 18:17:12 INFO - 2015-11-16 18:17:12,159 DEBUG : Generating results file: v8_7 18:17:12 INFO - 2015-11-16 18:17:12,159 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:17:12 INFO - 2015-11-16 18:17:12,213 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 18:17:12 INFO - 2015-11-16 18:17:12,213 DEBUG : process_Request line: dromaeo_css 6230.05 graph.html#tests=[[72,1,55]] 18:17:12 INFO - 2015-11-16 18:17:12,213 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:17:12 INFO - 2015-11-16 18:17:12,249 DEBUG : process_Request line: kraken 1555.60 graph.html#tests=[[232,1,55]] 18:17:12 INFO - 2015-11-16 18:17:12,249 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:17:12 INFO - 2015-11-16 18:17:12,273 DEBUG : process_Request line: v8_7 17547.97 graph.html#tests=[[230,1,55]] 18:17:12 INFO - 2015-11-16 18:17:12,274 INFO : javascript benchmark 18:17:12 INFO - 2015-11-16 18:17:12,276 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.95646609474693, 318.0966056399824, 322.77889645592785, 323.1436692764175, 324.0537630120048, 9642.855357169648, 9933.460313651378, 11001.119910407158, 16814.31856814318, 17701.203445844934, 9937.701868943943, 10962.177836662262, 11019.724506887333, 11261.155413343991, 11365.715857103576, 4083.12212874232, 4174.373843923413, 4276.6792490563175, 4279.33670281107, 4312.1806856697285, 3242.643309235982, 3407.727381809449, 4224.429701990238, 4285.507166675841, 4496.2581174106235, 4444.511103778598, 4464.861460327612, 4478.261086920655, 4487.775611219442, 4492.3710680504755, 4344.89137771555, 4416.690831641787, 4435.35687325336, 4474.060447306069, 4487.887802804923, 3729.3287208302495, 3732.104294969188, 3732.8133593320226, 3739.9626003739886, 3753.680937120348, 11659.06727461801, 11887.167898247126, 11931.701707457296, 12024.158308918291, 12175.147739658227, 1683.402392150781, 1705.7100292950104, 1712.9314827406888, 1720.8021077575988, 1893.9961820235296, 8994.460332380078, 9095.090490950919, 9222.584983675752, 9245.075492450702, 9378.624855005792, 1399.825021872266, 1481.9925900370538, 1482.4811316039409, 1494.4097081652687, 1502.3314624991883, 54200.45799542033, 55848.0, 56811.43188568144, 56829.71585142089, 57010.71494642583, 6032.879342413127, 6081.391860813972, 6170.969145154246, 6204.658743769046, 6231.376862313823, 7018.1929078155645, 7031.226565077837, 7035.0, 7047.40097091753, 7071.8939215911805, 4984.8753781155765, 5033.748312584356, 5069.011542749128, 5074.517920797518, 5079.873003174876, 5317.042932272228, 5329.0, 5342.0384330820825, 5345.732713364394, 5355.116405793001, 2766.7094955029434, 2788.762955148835, 2789.121426750567, 2800.7339302766204, 2802.8738706758245, 957.683964291782, 976.9936964926137, 985.2462865907586, 1008.9495525223709, 1045.7803861189084, 364.28054592180234, 406.92878746219293, 425.20486689890106, 435.7799311347749, 443.7803287372707, 10642.680719578426, 10844.511996960156, 11198.216124871344, 11226.214165008534, 11404.258723183133, 424.43550078395657, 436.1908659436699, 436.49366734587727, 442.7078128435217, 455.49667617283086, 5877.52979761618, 6014.278286605548, 6055.303640081447, 6090.0, 6122.510199184144, 374806.0, 378520.0, 381398.0, 385098.0, 445794.0, 67533.662331689, 67805.0, 69224.6538767303, 70058.2994170062, 70870.0, 466.349442527672, 474.5325854033774, 475.04278878060734, 476.09541870445736, 476.62584870876196, 10184.439855808001, 10384.948075259575, 10422.635207767691, 10424.895751042393, 10447.738806529593, 32633.0, 32906.0, 33331.16672083121, 33525.49711754277, 33894.15264618306, 44215.55784442114, 44316.33525497056, 44729.32906006347, 44751.77624111858, 44811.327830083224, 5648.350439699323, 5798.333191682842, 5800.883982320245, 5814.273215848019, 5829.912551311649, 10786.730331741455, 10871.40207288575, 10965.890341096487, 11199.60801371948, 11248.26886252391, 8137.064237612751, 8151.470154439942, 8374.874376884474, 8429.241368276884, 8985.371024028516, 8578.0, 9143.725688229364, 9224.446533208029, 9385.38994965325, 9412.67055653049, 9422.811543768948, 9537.332386732862, 9661.372010819274, 9717.80564388694, 9746.561404736945, 5676.978143934131, 5800.24596802413, 5873.647581145145, 5886.117082437669, 5903.881922361443, 9461.716148515556, 9557.474338911148, 9743.853842192515, 9793.85309220348, 9801.264905132286], "dojo.html": [3097.8605962731676, 3146.119086655736, 3174.460341741904, 3277.6558461361556, 3307.8180700061494, 5038.924416133761, 5182.8704282392955, 5232.581393488516, 5273.18265668821, 5308.362996440433, 5121.385433747955, 5158.871028224296, 5213.113770658988, 5248.527632513083, 5296.25852380666, 4827.710337379768, 4873.610111191114, 4911.8035278588995, 4932.852014439554, 4951.752412379366, 4933.555979961803, 5005.474425185358, 5022.121128802463, 5035.874103147414, 5051.898962020758, 4612.677112602119, 4719.174144524694, 4721.6458765592715, 4953.1332016896895, 4954.7274899880495, 4899.755012249373, 4920.778564964585, 4938.4814594467425, 4950.405951285833, 4961.776720047606, 4902.730349830758, 4903.779329930162, 4904.5831104356175, 4916.115099282128, 4936.827211047596, 5025.246213068032, 5065.848024559269, 5142.280080788692, 5146.588272938156, 5193.272941788153, 5501.972490137524, 5511.063119269734, 5513.283273174502, 5519.227308176858, 5552.250446189753, 5526.613137080406, 5548.55611551075, 5553.72231388433, 5576.275084239063, 5578.219049333096, 4868.269759536098, 4907.779149938297, 5006.123928312531, 5013.1227035268685, 5216.478352164791, 5647.943520564824, 5680.14797780328, 5696.572757043238, 5767.480926716616, 5770.221020162225, 5456.127019676912, 5463.3717122530625, 5467.699276539828, 5473.863153421196, 5482.122860342326, 5408.567314614821, 5429.755660995264, 5544.390117087117, 5545.057340252167, 5608.46719561641, 5294.100002999499, 5299.973500132474, 5310.283111779938, 5357.678539287655, 5457.426970168154, 5286.577073834161, 5301.496357845998, 5314.4951229633125, 5326.627136100436, 5343.919841202385, 4135.110951145518, 4166.0834616384345, 4222.092250166229, 4231.957680423218, 4252.91494170121, 3710.461983012448, 3734.7198960078103, 3808.4858544096746, 3836.558795738526, 3869.7484663497344, 5143.922841157386, 5150.4334523202415, 5156.613254005964, 5164.25118357836, 5172.767225474862, 5414.593905457106, 5523.6409633373705, 5594.804181853697, 5607.383187849333, 5634.943650563524, 4761.547652972962, 4837.250226214942, 4839.612830973514, 4856.562909338177, 5149.562287205555, 4609.124266389443, 4612.538746125428, 4628.097520983376, 4643.883902902455, 4676.0, 5381.19282107687, 5410.567154627542, 5426.620136590401, 5445.564354851682, 5543.307086614173, 5445.428230035789, 5509.449055094618, 5516.475934786189, 5528.419515950767, 5598.86002849932, 5681.659100453986, 5727.8854422912145, 5728.742206600629, 5735.3977832327, 5746.109353050284, 5281.709505977208, 5379.1393377059485, 5533.114701647878, 5564.944350556442, 5567.610267281251, 5342.065138600807, 5406.594505412031, 5415.052365836042, 5440.646357986719, 5451.945480545144, 5257.4742525747115, 5368.812091576776, 5370.409254981871, 5400.270963419888, 5410.323709536308, 5155.02054609623, 5303.0, 5386.730663466733, 5399.568034557147, 5461.071617825059, 5162.561182299547, 5287.339082614673, 5289.047971365191, 5309.017831701148, 5337.359516858002, 5396.21754845553, 5461.5357694596405, 5508.697021663847, 5522.447755224606, 5529.281193444826, 5133.024725302181, 5222.582193424593, 5344.75948582307, 5413.106837371947, 5427.294451721409], "mootools.html": [1167.7372591166984, 1316.091896591352, 1376.6214291069955, 1474.7492926202544, 1716.4164184177384, 6766.221884483286, 7229.349358557735, 7535.472516923811, 7719.073711154655, 7740.032495938008, 7502.662380192891, 7542.6228688565625, 7674.46278760487, 7684.884726729089, 7707.730229441971, 1873.8032506586817, 1906.332783525762, 2124.2458927080897, 2138.700581918533, 2147.6885851551515, 2146.64580344243, 2177.357679484548, 2185.9234926777567, 2198.1317379635034, 2199.098369668436, 2068.1934045722182, 2104.515961328895, 2122.352682431858, 2125.38363874477, 2127.2767259131892, 1901.2870173684869, 1958.1482055305987, 2066.5866826634733, 2098.7376577927757, 2108.5045014421753, 2092.393205970267, 2100.4853810816294, 2110.683397490389, 2111.0078263216265, 2112.3134981131193, 7602.54384736912, 7676.7313144040245, 7733.535987840692, 7772.106207786121, 7801.4929029612895, 4546.477155127137, 4685.812567497296, 4689.132510485571, 4691.695039822401, 4693.88265293367, 2678.9196324110308, 2684.952868381333, 2730.7678847298002, 2772.9722702772915, 2777.5833624956217, 809.6154326694832, 811.7037281392309, 822.5434883639577, 832.142892820396, 833.1460253240416, 10350.275480716353, 10351.534180961875, 10355.326903751233, 10391.948040259751, 10414.3751374917, 4103.9179216416105, 4142.79286035697, 4224.66202703783, 4304.397384366192, 4329.913401732011, 8896.377253592316, 8932.598033088527, 8942.150495702897, 8953.149450802164, 8957.14907083839, 4653.069386122789, 4682.227432473672, 4684.508126646721, 4684.601808846286, 4684.882877928079, 4217.472815898012, 4229.0273237155625, 4243.830246790094, 4256.957430425656, 4266.104118135227, 3584.175639602906, 3611.494390785292, 3620.4931309616672, 3641.362761516724, 3677.8344974476213, 1149.4424161140535, 1151.6026970695098, 1155.185594156118, 1181.6336935550007, 1190.6070996571111, 1210.0, 1216.7444836584416, 1238.0961897814645, 1242.018805143926, 1246.7755803955374, 7136.179339375934, 7169.6773645186095, 7184.209736928934, 7189.604571748604, 7191.424686025105, 432.67765514691126, 440.58144762475774, 458.54145854145855, 462.613717545853, 462.81256091283086, 5532.917006244909, 5590.0, 5608.6073974821375, 5620.353659329147, 5623.381428042912, 8877.245434138042, 8912.955435222782, 8932.910670893209, 8974.86537701935, 9058.048904865025, 8905.73282801517, 8913.0, 8915.331350148635, 8939.73180804577, 8943.016268210491, 6876.106106206161, 7061.0, 7080.398166155832, 7108.395786358217, 7160.06919100524, 6998.6150761708595, 7032.718691252498, 7059.71761129549, 7063.328983746535, 7089.397401220954, 7830.765077047698, 7870.488418252795, 7938.56337901421, 8018.83962320762, 8038.67845286182, 7975.441719079608, 8134.511929284262, 8263.256306932164, 8293.377996650155, 8317.126701696236, 6238.282597501346, 6527.51043671717, 6590.670466476561, 6636.800895972935, 6726.663666816542, 7131.144262688303, 7146.249643787328, 7196.820079498055, 7198.244184360567, 7238.02286691311, 6622.8344291393105, 6671.132752742113, 6682.431993280626, 6807.353301436356, 6823.078884350549, 5647.971760141338, 6078.118672792509, 6531.836704082436, 6652.135222421054, 6776.322367763184, 6828.317168283132, 6830.282820303796, 6845.041694162722, 6852.486063545154, 6898.517103802686, 6143.047827586553, 6165.445109940127, 6183.876322473436, 6191.25704915413, 6208.9689551551955, 6157.32269450369, 6337.081123237197, 6362.172917520693, 6378.1070650108095, 6380.489560835215], "ext.html": [513.5301199402547, 524.6091661712026, 524.7848382163312, 524.8005757812032, 538.8598964269294, 28713.569296460544, 31186.53220201696, 37570.436443453335, 38598.61401385985, 38660.033499162535, 40071.59928400715, 40683.79658101705, 40770.184596308056, 40895.795521022425, 40902.0, 7739.342155916754, 8503.319734421262, 8613.138686131368, 8621.741347759576, 8653.091425400336, 7693.115291741437, 10557.472126393688, 10616.150707943385, 10637.202209834293, 10684.358938463678, 10413.479326033668, 10414.687559373231, 10465.73835654111, 10483.528241229164, 10553.155747540217, 8000.759977200693, 8137.023557173118, 10382.584696612126, 10479.895201048006, 10518.263721539533, 10095.697129086138, 10347.844782328271, 10353.482325883675, 10372.170226381946, 10376.429296388696, 38930.80534597309, 39228.0, 39243.215135697414, 39275.21449570992, 39321.0, 2846.0, 2912.7669786417036, 2957.940841183186, 3197.952030719541, 3319.219983303946, 26227.0, 26677.599836002475, 26692.33269168267, 26854.194374168612, 26911.730882691118, 2060.5981833542464, 2069.2343832781817, 2150.35489353195, 2157.827373810107, 2234.8323875709225, 267633.0, 268556.0, 269504.0, 270379.0, 270677.0, 58965.41034589685, 59107.40892591105, 59278.11082833761, 59280.0, 59576.404235957954, 61556.38443615596, 61626.69186654038, 61636.38363616396, 62044.0, 62082.68958655268, 13981.510647127301, 14328.355224014944, 14397.136171829723, 14419.279036048156, 14421.42314307437, 10551.525181366856, 10587.84118238227, 10604.575816967235, 10613.204009699304, 10615.150787936947, 18955.826492156655, 19379.0, 19467.318643847397, 19495.805041949683, 19528.54887383326, 7181.6409179540815, 7433.553986760703, 7491.288327608869, 7501.0, 7504.962475187589, 867.5315329722006, 874.2001069021901, 901.3330135699536, 915.8992510823804, 929.1544694328129, 27647.0, 28469.145925622266, 28816.158145249618, 29633.239190102668, 29908.55137172944, 870.8693695945659, 939.234523863063, 941.1153515695224, 1031.510032734445, 1043.5043354406596, 14417.567472975827, 14701.0, 14847.777283340758, 14995.175265360293, 15135.772963405558, 287940.0, 290529.0, 290978.0, 294964.6762363307, 300212.0, 52107.478925210264, 53117.0, 53287.0, 53420.73289633605, 53442.198367024524, 1278.0797825565764, 1289.4842063174806, 1291.65125416139, 1292.4184117147322, 1293.5989843148654, 23234.0, 25694.87152564225, 27028.32429189286, 27268.31829204286, 27421.0, 44853.77573112114, 45668.0, 45867.0, 45960.770196148806, 46040.53959460362, 192086.0, 193092.0, 194070.0, 195547.0, 197864.0, 29284.853575731984, 29512.704872950995, 29664.0, 29894.551581725857, 29937.55093673553, 40457.0, 40835.0, 41249.0, 41354.379684305364, 41612.37581436341, 33485.0, 33722.66277337195, 34047.82976085104, 34209.82895085509, 34214.14464638404, 33475.33049339048, 33545.66454335425, 33702.15744606405, 33843.323133537684, 33887.491687625195, 34131.0, 34464.31071378508, 35328.29343413169, 35356.0, 35476.0, 28801.135965921058, 29170.854145729136, 30482.542761858145, 30669.8466507666, 30685.386292273583, 21444.142234310453, 21964.780352196914, 22016.559668806854, 22651.546969060855, 23653.0], "prototype.html": [303.80252835656825, 305.8638905686969, 309.82030422355035, 312.31602789890144, 312.4251377465463, 5918.201042859213, 5945.04879219325, 6003.489703375219, 6011.789587364443, 6090.23872015998, 5680.375158732547, 5859.619124756888, 5910.9113363299475, 5955.136505206742, 6017.909731354022, 4592.0, 4648.883777905546, 4649.58153766161, 4650.581447669709, 4672.345871577982, 4491.25894227452, 4587.747673877935, 4588.655850811186, 4658.510856360084, 4689.835855745049, 4526.936170000047, 4593.127305811901, 4620.330052142437, 4641.814327426916, 4665.346851440801, 4604.148232576984, 4620.283856002325, 4632.837850675244, 4654.511276315972, 4676.064787042571, 3979.422983667381, 3982.064214909523, 3998.04047028711, 3999.340108882031, 4003.83984640614, 5691.7723291068305, 5781.710914454303, 5842.5618078644275, 5863.8534036649, 5876.559258055663, 5170.793168273264, 5175.068487672217, 5180.8445746627285, 5182.870428239286, 5183.041137389558, 6287.182666253403, 6292.0, 6306.0, 6310.968445157745, 6328.905066424008, 4279.40088387626, 4286.271333873218, 4299.333603291495, 4302.010537576343, 4309.655227581786, 6349.4602958748565, 6577.408033277028, 6598.736050557924, 6610.636414997173, 6634.336566343423, 4356.194104090753, 4369.0, 4371.475422949266, 4385.035292235703, 4402.207602631557, 4419.779011049434, 4441.0, 4443.089166720879, 4490.101979604092, 4497.2804351304285, 5034.144195486776, 5138.177891537336, 5165.225216217597, 5173.922391164136, 5175.767090480937, 6280.340564240689, 6317.747290108436, 6324.9051264231075, 6340.619562826245, 6353.5234857385885, 1564.984350156484, 1569.395782623698, 1582.4698725926944, 1587.2936593162397, 1595.2661775583363, 1018.251585084962, 1035.2184101003695, 1038.3925403638955, 1044.9111825494765, 1047.4186826311318, 5735.885282294331, 5982.192404025488, 5982.820515384546, 6003.699815009232, 6017.699115044318, 6381.776637817654, 6513.73945042193, 6525.3474652535315, 6542.149520562297, 6548.6725663716625, 5908.202392676933, 6004.489618382399, 6029.728662210124, 6066.423689749467, 6073.787417440457, 3531.0466174133353, 3561.252137051248, 3568.197155640012, 3578.5526809148855, 3581.8209089545417, 6675.732970681119, 6774.491913106438, 6794.218664853605, 6805.523613347117, 6806.217285012188, 6815.0, 6830.624315662587, 6836.658167091626, 6837.179538455417, 6853.566983720807, 6782.389584937379, 6782.525223234326, 6794.490413219029, 6809.353111454305, 6828.897566536506, 6425.1968503937005, 6638.47315117516, 6640.933590664032, 6642.269350371552, 6679.432248258952, 6449.871002579828, 6508.153939987771, 6509.772157974448, 6522.271598026622, 6564.179477565304, 6767.560108592926, 6787.762428314985, 6797.0, 6804.4216241620015, 6810.931890681228, 4119.134981653886, 4439.667024973204, 4444.155610434007, 4448.7108337957925, 4456.264716321771, 6572.34276572339, 6588.110605068255, 6602.0, 6616.735330586723, 6623.735050597922, 6396.936030639634, 6406.263279722892, 6408.455281301141, 6410.647414392067, 6415.294317625151, 6186.381361863778, 6348.365163483615, 6390.13733146038, 6404.647744374104, 6421.678916054272, 6243.906341404973, 6245.937540624535, 6246.500279977682, 6252.687365631609, 6253.7185826637, 6303.873922521616, 6338.112664227104, 6359.523035772429, 6376.330485298977, 6415.101885736094, 6040.486558642565, 6094.542909281733, 6238.812835614939, 6251.562390632612, 6275.278342990615], "yui.html": [725.0538047847557, 725.836686745482, 731.6926890705903, 747.6336595068417, 785.9646315915783, 12832.935835320823, 13038.869611303884, 13042.413091410874, 13054.543090991818, 13085.60743177705, 12127.332996685202, 12220.694482637939, 13481.865181348208, 13483.12359696619, 13657.248851313174, 645.4707140145083, 651.8533330000736, 813.1299509524811, 825.2613910550054, 826.962786674601, 817.9550124743137, 821.8068753842842, 821.9589020548949, 830.2818062376061, 833.6707000734706, 860.5310105992218, 862.2713806833216, 864.3042350907517, 864.7967727584013, 865.5628907401754, 687.549654975989, 698.3016983016983, 845.0915266088979, 857.8327226190864, 863.6415887406719, 627.4980015987237, 628.0798630007016, 630.6247782569363, 631.9146915166485, 632.5161251642497, 12744.745105097845, 12866.806997895039, 12870.871291287061, 12914.354282285942, 12993.220406775623, 8696.652133914637, 8784.341174411944, 8937.240334571568, 9121.0, 9196.356255062148, 8256.545889976049, 8366.53984030878, 8382.16178382163, 8585.01272353681, 8599.742007739715, 2803.915882523507, 2845.075350511092, 2845.2886778305424, 2862.169970708492, 2899.666538348075, 41262.38106428406, 41760.58239417597, 42080.0, 42101.1579768406, 42184.156316873494, 5348.331458567679, 5379.946200537945, 5401.081816091274, 5424.620276580601, 5608.355039170548, 10548.789024219474, 10549.525271362807, 10587.735306617396, 10616.787664246673, 10624.946875265574, 5345.518903298722, 5401.378841433286, 5477.45225477457, 5477.835664930059, 5608.691521966331, 3589.7564022485944, 3647.0517665407187, 3656.689181419556, 3722.590515043343, 3755.75587586806, 2434.5252675728416, 2465.4083020075054, 2471.9629205561932, 2480.057578120339, 2484.1181380609983, 362.4780316344508, 364.67726062434406, 377.63935441653706, 378.30392078575005, 378.6705566157461, 520.5601266929514, 538.9811356602501, 545.5117669685609, 579.7536047180016, 579.9188113664006, 7912.208779122042, 7998.280154786097, 8226.753197404087, 8247.628856701464, 8381.874271885927, 456.49329244538535, 491.3440556856565, 575.4102045403495, 589.6167491130799, 602.728772052578, 3478.669526394988, 3506.579210494757, 3705.2959937611768, 3712.579594181092, 3730.0301921500063, 56643.71678141665, 57811.42188578145, 58057.4194258052, 58154.4184558149, 58818.70590647105, 49529.752351238734, 50431.49568504342, 50789.746051270246, 50929.0, 50997.235041473665, 44437.33343999842, 44969.775151124035, 45328.3200751989, 46363.30455043177, 46625.766871165426, 7124.145102587722, 7158.534695244793, 7187.7843664690145, 7201.207867134715, 7383.815404614713, 33534.49698254479, 34028.0, 34317.0, 34382.65617343794, 34973.47539786956, 41892.79053604713, 44810.55189448064, 45472.0, 46504.7674761624, 46508.30237546507, 6787.966060169668, 6806.719748884179, 6934.306569343227, 7061.611611361424, 7312.305330993547, 9656.32405731592, 9728.902710973083, 9912.653057142965, 10240.53917573696, 10255.94872025635, 9276.814463710823, 9429.894285032888, 9431.57557909882, 9438.716838494582, 9463.242940564876, 9097.317701172306, 9474.85787713171, 9557.713268601952, 9899.0, 9966.103050725469, 8563.914360856312, 8607.48355098696, 8831.69089081879, 9151.816963660822, 9376.578053987723, 8440.788980275542, 8501.659933602587, 8502.14978502145, 8711.21599056088, 8835.823283534422, 7053.259407762111, 8267.751967440987, 8692.913070869463, 8957.0, 9061.09389061115]}, "summary": {"lowerIsBetter": false, "suite": 6230.043634757638, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6097.78562398737, "unit": "ms", "value": 6097.78562398737}, "dojo.html": {"lowerIsBetter": false, "filtered": 5097.008523431735, "unit": "ms", "value": 5097.008523431735}, "mootools.html": {"lowerIsBetter": false, "filtered": 4194.778813866664, "unit": "ms", "value": 4194.778813866664}, "ext.html": {"lowerIsBetter": false, "filtered": 17476.692598774556, "unit": "ms", "value": 17476.692598774556}, "prototype.html": {"lowerIsBetter": false, "filtered": 4757.746136344377, "unit": "ms", "value": 4757.746136344377}, "yui.html": {"lowerIsBetter": false, "filtered": 5393.256711268865, "unit": "ms", "value": 5393.256711268865}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1447725421, "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": "20151116154007", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 162.0, 163.0, 168.0, 173.0, 175.0, 171.0, 168.0, 174.0], "ai-astar": [104.0, 105.0, 102.0, 106.0, 106.0, 107.0, 98.0, 105.0, 109.0, 107.0], "imaging-gaussian-blur": [123.0, 121.0, 114.0, 121.0, 130.0, 129.0, 121.0, 118.0, 123.0, 129.0], "audio-beat-detection": [161.0, 134.0, 152.0, 165.0, 126.0, 152.0, 151.0, 132.0, 168.0, 130.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 70.0, 70.0, 71.0, 73.0, 72.0, 73.0, 74.0], "stanford-crypto-pbkdf2": [158.0, 143.0, 158.0, 156.0, 166.0, 151.0, 164.0, 164.0, 158.0, 146.0], "json-parse-financial": [63.0, 59.0, 59.0, 59.0, 59.0, 60.0, 65.0, 69.0, 62.0, 60.0], "stanford-crypto-sha256-iterative": [71.0, 70.0, 69.0, 71.0, 72.0, 75.0, 73.0, 74.0, 75.0, 75.0], "audio-fft": [73.0, 83.0, 87.0, 86.0, 69.0, 72.0, 77.0, 87.0, 89.0, 88.0], "imaging-darkroom": [127.0, 125.0, 126.0, 136.0, 136.0, 135.0, 130.0, 135.0, 135.0, 136.0], "stanford-crypto-ccm": [134.0, 124.0, 143.0, 143.0, 138.0, 150.0, 145.0, 137.0, 131.0, 137.0], "audio-oscillator": [98.0, 102.0, 139.0, 89.0, 90.0, 94.0, 132.0, 95.0, 95.0, 135.0], "stanford-crypto-aes": [86.0, 88.0, 85.0, 87.0, 90.0, 92.0, 91.0, 95.0, 95.0, 93.0], "imaging-desaturate": [95.0, 98.0, 103.0, 100.0, 100.0, 100.0, 110.0, 109.0, 109.0, 108.0]}, "summary": {"lowerIsBetter": true, "suite": 1555.6000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.1, "unit": "ms", "value": 81.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 156.4, "unit": "ms", "value": 156.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 138.2, "unit": "ms", "value": 138.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 132.1, "unit": "ms", "value": 132.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.5, "unit": "ms", "value": 61.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 106.9, "unit": "ms", "value": 106.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 104.9, "unit": "ms", "value": 104.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 167.7, "unit": "ms", "value": 167.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.5, "unit": "ms", "value": 72.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.9, "unit": "ms", "value": 70.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 122.9, "unit": "ms", "value": 122.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 90.2, "unit": "ms", "value": 90.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 103.2, "unit": "ms", "value": 103.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1447725421, "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": "20151116154007", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.28793471925394], "Encrypt": [330.1419610432486], "NavierStokes": [5982.142857142857], "Decrypt": [5970.238095238095], "Splay": [645.1612903225806], "Richards": [166.25103906899417], "RegExp": [31343.75], "Earley": [1049.3179433368311], "Boyer": [14069.444444444445], "RayTrace": [1990.0596421471173]}, "summary": {"lowerIsBetter": false, "suite": 17547.97333964813, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.309346, "unit": "score", "value": 340.309346}, "Encrypt": {"lowerIsBetter": false, "filtered": 806.2622489999997, "unit": "score", "value": 806.2622489999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 248.07164179104493, "unit": "score", "value": 248.07164179104493}, "Decrypt": {"lowerIsBetter": false, "filtered": 44.58465403788634, "unit": "score", "value": 44.58465403788634}, "Splay": {"lowerIsBetter": false, "filtered": 126.31105000000005, "unit": "score", "value": 126.31105000000005}, "RegExp": {"lowerIsBetter": false, "filtered": 29.064327018943178, "unit": "score", "value": 29.064327018943178}, "Richards": {"lowerIsBetter": false, "filtered": 212.3415300000001, "unit": "score", "value": 212.3415300000001}, "Earley": {"lowerIsBetter": false, "filtered": 635.1392389999999, "unit": "score", "value": 635.1392389999999}, "Boyer": {"lowerIsBetter": false, "filtered": 47.36953208292197, "unit": "score", "value": 47.36953208292197}, "RayTrace": {"lowerIsBetter": false, "filtered": 371.84262437562455, "unit": "score", "value": 371.84262437562455}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0044"}, "testrun": {"date": 1447725421, "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": "20151116154007", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}] 18:17:12 INFO - RETURN: dromaeo_css: 6230.05 18:17:12 INFO - RETURN: kraken: 1555.60 18:17:12 INFO - RETURN: v8_7: 17547.97 18:17:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "17547.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1555.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6230.05"}}} 18:17:12 INFO - Return code: 0 18:17:12 INFO - # TBPL SUCCESS # 18:17:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:17:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:17:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:17:12 INFO - 2015-11-16 18:17:12.403 screenresolution[2345:77058] starting screenresolution argv=screenresolution get 18:17:12 INFO - 2015-11-16 18:17:12.406 screenresolution[2345:77058] Display 0: 1600x1200x32@60 18:17:12 INFO - 2015-11-16 18:17:12.413 screenresolution[2346:77061] starting screenresolution argv=screenresolution list 18:17:12 INFO - Available Modes on Display 0 18:17:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:17:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:17:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:17:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:17:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:17:12 INFO - Intel HD Graphics 3000: 18:17:12 INFO - Chipset Model: Intel HD Graphics 3000 18:17:12 INFO - Type: GPU 18:17:12 INFO - Bus: Built-In 18:17:12 INFO - VRAM (Total): 512 MB 18:17:12 INFO - VRAM (Dynamic, Max): 10 18:17:12 INFO - Vendor: Intel (0x8086) 18:17:12 INFO - Device ID: 0x0116 18:17:12 INFO - Revision ID: 0x0009 18:17:12 INFO - Displays: 18:17:12 INFO - Display: 18:17:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:17:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:17:12 INFO - Display Serial Number: 1600x1200 60 18:17:12 INFO - Main Display: Yes 18:17:12 INFO - Mirror: Off 18:17:12 INFO - Online: Yes 18:17:12 INFO - Rotation: Supported 18:17:12 INFO - Return code: 0 18:17:12 INFO - Running post-action listener: _resource_record_post_action 18:17:12 INFO - Running post-run listener: _resource_record_post_run 18:17:13 INFO - Total resource usage - Wall time: 1249s; CPU: 30.0%; Read bytes: 282624; Write bytes: 688400896; Read time: 118; Write time: 48202 18:17:13 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 340924928; Write bytes: 337504256; Read time: 33061; Write time: 6841 18:17:13 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 282624; Write bytes: 339089920; Read time: 118; Write time: 39984 18:17:13 INFO - Running post-run listener: _upload_blobber_files 18:17:13 INFO - Blob upload gear active. 18:17:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:17:13 INFO - Copying logs to upload dir... 18:17:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1301.932543 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-16 18:17:13.810287) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:17:13.814073) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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/G6k-qqZ8TImy9HKGVMCGzw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010058 build_url: 'https://queue.taskcluster.net/v1/task/G6k-qqZ8TImy9HKGVMCGzw/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-16 18:17:13.840462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:17:13.840813) ========= 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.TN0XojT1CR/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.8fU8zLOqh2/Listeners TMPDIR=/var/folders/0m/98vh6mr96197mhwl86256q3000000w/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.005382 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:17:13.890522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:17:13.890863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:17:13.891253) ========= ========= Total master_lag: 0.23 =========