builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0091 starttime: 1447674284.3 results: success (0) buildid: 20151116025234 builduid: 6d33d96132864af8934e5a363f83bb7e revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.297235) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.297888) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.298329) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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.006116 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.333129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.333713) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.363646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.364047) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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.005345 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.413493) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.413868) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.414270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.414583) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:44:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.23M=0.002s 2015-11-16 03:44:44 (7.23 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.435453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.866775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.867251) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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.020000 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:44.919515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 03:44:44.919901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --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 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:44:44,983 truncating revision to first 12 chars 2015-11-16 03:44:44,983 Setting DEBUG logging. 2015-11-16 03:44:44,983 attempt 1/10 2015-11-16 03:44:44,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 03:44:46,031 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377074 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 03:44:46.316703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:46.317440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:46.330746) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:46.331152) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:44:46.331705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 17 secs) (at 2015-11-16 03:44:46.332044) ========= /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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:44:46 INFO - MultiFileLogger online at 20151116 03:44:46 in /builds/slave/test 03:44:46 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 03:44:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:46 INFO - {'append_to_log': False, 03:44:46 INFO - 'base_work_dir': '/builds/slave/test', 03:44:46 INFO - 'blob_upload_branch': 'Firefox', 03:44:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:46 INFO - 'branch': 'Firefox', 03:44:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:46 INFO - 'config_files': ('talos/mac_config.py',), 03:44:46 INFO - 'default_actions': ('clobber', 03:44:46 INFO - 'read-buildbot-config', 03:44:46 INFO - 'download-and-extract', 03:44:46 INFO - 'populate-webroot', 03:44:46 INFO - 'create-virtualenv', 03:44:46 INFO - 'install', 03:44:46 INFO - 'run-tests'), 03:44:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:46 INFO - 'download_minidump_stackwalk': True, 03:44:46 INFO - 'download_symbols': 'ondemand', 03:44:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:46 INFO - 'installer_path': 'installer.exe', 03:44:46 INFO - 'log_level': 'info', 03:44:46 INFO - 'log_name': 'talos', 03:44:46 INFO - 'log_to_console': True, 03:44:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:44:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:44:46 INFO - 'opt_config_files': (), 03:44:46 INFO - 'pip_index': False, 03:44:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:44:46 INFO - 'cmd': ('bash', 03:44:46 INFO - '-c', 03:44:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:44:46 INFO - 'enabled': True, 03:44:46 INFO - 'halt_on_failure': False, 03:44:46 INFO - 'name': 'check_screen_resolution'},), 03:44:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:44:46 INFO - 'cmd': ('bash', 03:44:46 INFO - '-c', 03:44:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:44:46 INFO - 'enabled': True, 03:44:46 INFO - 'halt_on_failure': False, 03:44:46 INFO - 'name': 'check_screen_resolution'},), 03:44:46 INFO - 'run_cmd_checks_enabled': True, 03:44:46 INFO - 'sps_profile': False, 03:44:46 INFO - 'sps_profile_interval': 0, 03:44:46 INFO - 'suite': 'dromaeojs', 03:44:46 INFO - 'system_bits': '64', 03:44:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:46 INFO - 'title': 't-yosemite-r5-0091', 03:44:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:46 INFO - 'use_talos_json': True, 03:44:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:46 INFO - 'work_dir': 'build'} 03:44:46 INFO - ##### 03:44:46 INFO - ##### Running clobber step. 03:44:46 INFO - ##### 03:44:46 INFO - Running pre-action listener: _resource_record_pre_action 03:44:46 INFO - Running main action method: clobber 03:44:46 INFO - rmtree: /builds/slave/test/build 03:44:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - ##### 03:44:48 INFO - ##### Running read-buildbot-config step. 03:44:48 INFO - ##### 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: read_buildbot_config 03:44:48 INFO - Using buildbot properties: 03:44:48 INFO - { 03:44:48 INFO - "properties": { 03:44:48 INFO - "buildnumber": 561, 03:44:48 INFO - "product": "firefox", 03:44:48 INFO - "script_repo_revision": "production", 03:44:48 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 03:44:48 INFO - "repository": "", 03:44:48 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 03:44:48 INFO - "buildid": "20151116025234", 03:44:48 INFO - "slavename": "t-yosemite-r5-0091", 03:44:48 INFO - "pgo_build": "False", 03:44:48 INFO - "basedir": "/builds/slave/test", 03:44:48 INFO - "project": "", 03:44:48 INFO - "platform": "yosemite", 03:44:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:44:48 INFO - "slavebuilddir": "test", 03:44:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:44:48 INFO - "branch": "mozilla-central", 03:44:48 INFO - "repo_path": "mozilla-central", 03:44:48 INFO - "stage_platform": "macosx64", 03:44:48 INFO - "builduid": "6d33d96132864af8934e5a363f83bb7e", 03:44:48 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 03:44:48 INFO - }, 03:44:48 INFO - "sourcestamp": { 03:44:48 INFO - "repository": "", 03:44:48 INFO - "hasPatch": false, 03:44:48 INFO - "project": "", 03:44:48 INFO - "branch": "mozilla-central-macosx64-talos", 03:44:48 INFO - "changes": [ 03:44:48 INFO - { 03:44:48 INFO - "category": null, 03:44:48 INFO - "files": [ 03:44:48 INFO - { 03:44:48 INFO - "url": null, 03:44:48 INFO - "name": "https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:44:48 INFO - } 03:44:48 INFO - ], 03:44:48 INFO - "repository": "", 03:44:48 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 03:44:48 INFO - "who": "nigelbabu@gmail.com", 03:44:48 INFO - "when": 1447674230, 03:44:48 INFO - "number": 6665545, 03:44:48 INFO - "comments": "Backed out changeset 5fb6f8b316ca (bug 1185403) for win7 pgo bc1 perma-orange, a=bustage", 03:44:48 INFO - "project": "", 03:44:48 INFO - "at": "Mon 16 Nov 2015 03:43:50", 03:44:48 INFO - "branch": "mozilla-central-macosx64-talos", 03:44:48 INFO - "revlink": "", 03:44:48 INFO - "properties": [ 03:44:48 INFO - [ 03:44:48 INFO - "buildid", 03:44:48 INFO - "20151116025234", 03:44:48 INFO - "Change" 03:44:48 INFO - ], 03:44:48 INFO - [ 03:44:48 INFO - "builduid", 03:44:48 INFO - "6d33d96132864af8934e5a363f83bb7e", 03:44:48 INFO - "Change" 03:44:48 INFO - ], 03:44:48 INFO - [ 03:44:48 INFO - "pgo_build", 03:44:48 INFO - "False", 03:44:48 INFO - "Change" 03:44:48 INFO - ] 03:44:48 INFO - ], 03:44:48 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 03:44:48 INFO - } 03:44:48 INFO - ], 03:44:48 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 03:44:48 INFO - } 03:44:48 INFO - } 03:44:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - ##### 03:44:48 INFO - ##### Running download-and-extract step. 03:44:48 INFO - ##### 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: download_and_extract 03:44:48 INFO - mkdir: /builds/slave/test/build/tests 03:44: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')]} 03:44:48 INFO - https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/test_packages.json 03:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/test_packages.json 03:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:44:49 INFO - Downloaded 1149 bytes. 03:44:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:44:49 INFO - Using the following test package requirements: 03:44:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:44:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:44:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'jsshell-mac.zip'], 03:44:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:44:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:44:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:44:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:44:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:44:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:44:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:44:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:44:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:44:49 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')]} 03:44:49 INFO - https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:44:51 INFO - Downloaded 17464065 bytes. 03:44:51 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 03:44:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:44:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:44:57 INFO - Return code: 0 03:44:57 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 03:44:57 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')]} 03:44:57 INFO - https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:44:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:44:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:44:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:45:12 INFO - Downloaded 17464065 bytes. 03:45:12 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 03:45:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:45:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:45:20 INFO - Return code: 0 03:45:20 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')]} 03:45:20 INFO - https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:45:22 INFO - Downloaded 11131693 bytes. 03:45:22 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 03:45:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:45:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:45:23 INFO - Return code: 0 03:45: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')]} 03:45:23 INFO - https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/84cS3h34QLKhJNe9MTCCTA/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 03:45:29 INFO - Downloaded 108672473 bytes. 03:45:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:45:29 INFO - mkdir: /builds/slave/test/properties 03:45:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:29 INFO - Contents: 03:45:29 INFO - build_url:https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:45:29 INFO - Running post-action listener: _resource_record_post_action 03:45:29 INFO - Running post-action listener: set_extra_try_arguments 03:45:29 INFO - ##### 03:45:29 INFO - ##### Running populate-webroot step. 03:45:29 INFO - ##### 03:45:29 INFO - Running pre-action listener: _resource_record_pre_action 03:45:29 INFO - Running main action method: populate_webroot 03:45:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:29 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:45:29 INFO - '../fennec_ids.txt'], 03:45:29 INFO - 'tests': ['tcheck2']}, 03:45:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:29 INFO - '--tppagecycles', 03:45:29 INFO - '7'], 03:45:29 INFO - 'tests': ['tsvgm']}}, 03:45:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:45:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:45:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:45:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'tests': ['damp', 'tps']}, 03:45:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['damp', 'tps']}, 03:45:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:45:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:29 INFO - 'other': {'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'other_l64': {'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'other_nol64': {'tests': ['a11yr', 03:45:29 INFO - 'ts_paint', 03:45:29 INFO - 'tpaint', 03:45:29 INFO - 'sessionrestore', 03:45:29 INFO - 'sessionrestore_no_auto_restore']}, 03:45:29 INFO - 'svgr': {'tests': ['tsvgx', 03:45:29 INFO - 'tsvgr_opacity', 03:45:29 INFO - 'tart', 03:45:29 INFO - 'tscrollx', 03:45:29 INFO - 'cart']}, 03:45:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['tsvgx', 03:45:29 INFO - 'tsvgr_opacity', 03:45:29 INFO - 'tart', 03:45:29 INFO - 'tscrollx', 03:45:29 INFO - 'cart']}, 03:45:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'tests': ['tp5o']}, 03:45:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'talos_options': ['--e10s'], 03:45:29 INFO - 'tests': ['tp5o']}, 03:45:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'talos_options': ['--xperf_path', 03:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:29 INFO - 'tests': ['tp5n']}, 03:45:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:29 INFO - 'talos_options': ['--e10s', 03:45:29 INFO - '--xperf_path', 03:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:29 INFO - 'tests': ['tp5n']}}, 03:45:29 INFO - 'talos.zip': {'path': '', 03:45:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:29 INFO - Running post-action listener: _resource_record_post_action 03:45:29 INFO - ##### 03:45:29 INFO - ##### Running create-virtualenv step. 03:45:29 INFO - ##### 03:45:29 INFO - Running pre-action listener: _resource_record_pre_action 03:45:29 INFO - Running main action method: create_virtualenv 03:45:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:29 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 03:45:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:29 INFO - Using real prefix '/tools/python27' 03:45:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:34 INFO - Installing pip.................done. 03:45:34 INFO - Return code: 0 03:45:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:34 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 03:45:34 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 03:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:34 INFO - 'HOME': '/Users/cltbld', 03:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:34 INFO - 'LOGNAME': 'cltbld', 03:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:34 INFO - 'MOZ_NO_REMOTE': '1', 03:45:34 INFO - 'NO_EM_RESTART': '1', 03:45:34 INFO - 'PAGER': '/bin/cat', 03:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:34 INFO - 'PWD': '/builds/slave/test', 03:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:34 INFO - 'SHELL': '/bin/bash', 03:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:34 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:34 INFO - 'USER': 'cltbld', 03:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:34 INFO - 'XPC_FLAGS': '0x0', 03:45:34 INFO - 'XPC_SERVICE_NAME': '0', 03:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:35 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 03:45:35 INFO - Cleaning up... 03:45:35 INFO - Return code: 0 03:45:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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')]} 03:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:35 INFO - 'HOME': '/Users/cltbld', 03:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:35 INFO - 'LOGNAME': 'cltbld', 03:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:35 INFO - 'MOZ_NO_REMOTE': '1', 03:45:35 INFO - 'NO_EM_RESTART': '1', 03:45:35 INFO - 'PAGER': '/bin/cat', 03:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:35 INFO - 'PWD': '/builds/slave/test', 03:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:35 INFO - 'SHELL': '/bin/bash', 03:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:35 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:35 INFO - 'USER': 'cltbld', 03:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:35 INFO - 'XPC_FLAGS': '0x0', 03:45:35 INFO - 'XPC_SERVICE_NAME': '0', 03:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:35 INFO - Downloading/unpacking psutil>=0.7.1 03:45:35 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 03:45:35 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 03:45:35 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 03:45:35 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 03:45:35 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 03:45:35 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 03:45:37 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:45:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:38 INFO - Installing collected packages: psutil 03:45:38 INFO - Running setup.py install for psutil 03:45:38 INFO - building 'psutil._psutil_osx' extension 03:45:38 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 03:45:38 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 03:45:38 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 03:45:38 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 03:45:38 INFO - building 'psutil._psutil_posix' extension 03:45:38 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 03:45:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:45:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:45:38 INFO - ^ 03:45:38 INFO - 1 warning generated. 03:45:38 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 03:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:39 INFO - Successfully installed psutil 03:45:39 INFO - Cleaning up... 03:45:39 INFO - Return code: 0 03:45:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:39 INFO - 'HOME': '/Users/cltbld', 03:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:39 INFO - 'LOGNAME': 'cltbld', 03:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:39 INFO - 'MOZ_NO_REMOTE': '1', 03:45:39 INFO - 'NO_EM_RESTART': '1', 03:45:39 INFO - 'PAGER': '/bin/cat', 03:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:39 INFO - 'PWD': '/builds/slave/test', 03:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:39 INFO - 'SHELL': '/bin/bash', 03:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:39 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:39 INFO - 'USER': 'cltbld', 03:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:39 INFO - 'XPC_FLAGS': '0x0', 03:45:39 INFO - 'XPC_SERVICE_NAME': '0', 03:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:45:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:45:42 INFO - Installing collected packages: mozsystemmonitor 03:45:42 INFO - Running setup.py install for mozsystemmonitor 03:45:42 INFO - Successfully installed mozsystemmonitor 03:45:42 INFO - Cleaning up... 03:45:42 INFO - Return code: 0 03:45:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:42 INFO - 'HOME': '/Users/cltbld', 03:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:42 INFO - 'LOGNAME': 'cltbld', 03:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:42 INFO - 'MOZ_NO_REMOTE': '1', 03:45:42 INFO - 'NO_EM_RESTART': '1', 03:45:42 INFO - 'PAGER': '/bin/cat', 03:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:42 INFO - 'PWD': '/builds/slave/test', 03:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:42 INFO - 'SHELL': '/bin/bash', 03:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:42 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:42 INFO - 'USER': 'cltbld', 03:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:42 INFO - 'XPC_FLAGS': '0x0', 03:45:42 INFO - 'XPC_SERVICE_NAME': '0', 03:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:42 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 03:45:42 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 03:45:42 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 03:45:42 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 03:45:42 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 03:45:42 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 03:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:46 INFO - Downloading docopt-0.6.1.tar.gz 03:45:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:46 INFO - Running setup.py install for blobuploader 03:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:46 INFO - Running setup.py install for requests 03:45:47 INFO - Running setup.py install for docopt 03:45:47 INFO - Successfully installed blobuploader requests docopt 03:45:47 INFO - Cleaning up... 03:45:47 INFO - Return code: 0 03:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:47 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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:47 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 03:45:47 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 03:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:47 INFO - 'HOME': '/Users/cltbld', 03:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:47 INFO - 'LOGNAME': 'cltbld', 03:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:47 INFO - 'MOZ_NO_REMOTE': '1', 03:45:47 INFO - 'NO_EM_RESTART': '1', 03:45:47 INFO - 'PAGER': '/bin/cat', 03:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:47 INFO - 'PWD': '/builds/slave/test', 03:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:47 INFO - 'SHELL': '/bin/bash', 03:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:47 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:47 INFO - 'USER': 'cltbld', 03:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:47 INFO - 'XPC_FLAGS': '0x0', 03:45:47 INFO - 'XPC_SERVICE_NAME': '0', 03:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:47 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-YhaKkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-vs5OQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-TARQtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-Hlo6hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-DoCXjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-qpKkUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-cEkyIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-inksyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:48 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-3mdKoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-O4EIus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-_1W_tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-6voVPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-rWwRpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-4kCL64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-FocKTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-7bIAKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:49 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-9jB6zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:50 INFO - Running setup.py install for manifestparser 03:45:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:50 INFO - Running setup.py install for mozcrash 03:45:50 INFO - Running setup.py install for mozdebug 03:45:50 INFO - Running setup.py install for mozdevice 03:45:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:50 INFO - Running setup.py install for mozfile 03:45:50 INFO - Running setup.py install for mozhttpd 03:45:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozinfo 03:45:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozInstall 03:45:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozleak 03:45:51 INFO - Running setup.py install for mozlog 03:45:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for moznetwork 03:45:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozprocess 03:45:52 INFO - Running setup.py install for mozprofile 03:45:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozrunner 03:45:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozscreenshot 03:45:52 INFO - Running setup.py install for moztest 03:45:52 INFO - Running setup.py install for mozversion 03:45:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:53 INFO - Cleaning up... 03:45:53 INFO - Return code: 0 03:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:53 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')]} 03:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:53 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')]} 03:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:53 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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:53 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 03:45:53 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 03:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:53 INFO - 'HOME': '/Users/cltbld', 03:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:53 INFO - 'LOGNAME': 'cltbld', 03:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:53 INFO - 'MOZ_NO_REMOTE': '1', 03:45:53 INFO - 'NO_EM_RESTART': '1', 03:45:53 INFO - 'PAGER': '/bin/cat', 03:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:53 INFO - 'PWD': '/builds/slave/test', 03:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:53 INFO - 'SHELL': '/bin/bash', 03:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:53 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:53 INFO - 'USER': 'cltbld', 03:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:53 INFO - 'XPC_FLAGS': '0x0', 03:45:53 INFO - 'XPC_SERVICE_NAME': '0', 03:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:53 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-sIOUwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:53 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:53 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-ZPhFXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:53 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-IsUtEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:53 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-IAR12m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-A8Hdmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-D36nOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-HaoHxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-Fvhpig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-P78HWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-0csEoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-t2lyIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:54 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:54 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-RQ4vor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:55 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)) 03:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:55 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-cmdNLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:55 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)) 03:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:55 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-OvuVVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:55 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)) 03:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:55 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-PwHwSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:55 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)) 03:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:55 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-oaCE3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:55 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)) 03:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:55 INFO - Running setup.py (path:/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/pip-jsxK05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:55 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)) 03:45:55 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)) 03:45:55 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)) 03:45:55 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)) 03:45:55 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)) 03:45:55 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)) 03:45:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:55 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 03:45:55 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 03:45:55 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 03:45:55 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 03:45:55 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 03:45:55 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 03:45:58 INFO - Downloading blessings-1.5.1.tar.gz 03:45:58 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:58 INFO - Installing collected packages: blessings 03:45:58 INFO - Running setup.py install for blessings 03:45:58 INFO - Successfully installed blessings 03:45:58 INFO - Cleaning up... 03:45:58 INFO - Return code: 0 03:45:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:58 INFO - Reading from file tmpfile_stdout 03:45:58 INFO - Current package versions: 03:45:58 INFO - blessings == 1.5.1 03:45:58 INFO - blobuploader == 1.2.4 03:45:58 INFO - docopt == 0.6.1 03:45:58 INFO - manifestparser == 1.1 03:45:58 INFO - mozInstall == 1.12 03:45:58 INFO - mozcrash == 0.16 03:45:58 INFO - mozdebug == 0.1 03:45:58 INFO - mozdevice == 0.47 03:45:58 INFO - mozfile == 1.2 03:45:58 INFO - mozhttpd == 0.7 03:45:58 INFO - mozinfo == 0.9 03:45:58 INFO - mozleak == 0.1 03:45:58 INFO - mozlog == 3.0 03:45:58 INFO - moznetwork == 0.27 03:45:58 INFO - mozprocess == 0.22 03:45:58 INFO - mozprofile == 0.27 03:45:58 INFO - mozrunner == 6.11 03:45:58 INFO - mozscreenshot == 0.1 03:45:58 INFO - mozsystemmonitor == 0.0 03:45:58 INFO - moztest == 0.7 03:45:58 INFO - mozversion == 1.4 03:45:58 INFO - psutil == 3.1.1 03:45:58 INFO - requests == 1.2.3 03:45:58 INFO - wsgiref == 0.1.2 03:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:58 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')]} 03:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:58 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')]} 03:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:58 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 0x1104bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff54974a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, '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.wllGRcsn6B/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.8r1YdwNoDE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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 03:45:58 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 03:45:58 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 03:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:58 INFO - 'HOME': '/Users/cltbld', 03:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:58 INFO - 'LOGNAME': 'cltbld', 03:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:58 INFO - 'MOZ_NO_REMOTE': '1', 03:45:58 INFO - 'NO_EM_RESTART': '1', 03:45:58 INFO - 'PAGER': '/bin/cat', 03:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:58 INFO - 'PWD': '/builds/slave/test', 03:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:58 INFO - 'SHELL': '/bin/bash', 03:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:45:58 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:58 INFO - 'USER': 'cltbld', 03:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:58 INFO - 'XPC_FLAGS': '0x0', 03:45:58 INFO - 'XPC_SERVICE_NAME': '0', 03:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:59 INFO - Cleaning up... 03:45:59 INFO - Return code: 0 03:45:59 INFO - Running post-action listener: _resource_record_post_action 03:45:59 INFO - Running post-action listener: _start_resource_monitoring 03:45:59 INFO - Starting resource monitoring. 03:45:59 INFO - ##### 03:45:59 INFO - ##### Running install step. 03:45:59 INFO - ##### 03:45:59 INFO - Running pre-action listener: _resource_record_pre_action 03:45:59 INFO - Running main action method: install 03:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:59 INFO - Reading from file tmpfile_stdout 03:45:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:59 INFO - Reading from file tmpfile_stdout 03:45:59 INFO - Output received: 03:45:59 INFO - Usage: mozinstall [options] installer 03:45:59 INFO - Options: 03:45:59 INFO - -h, --help show this help message and exit 03:45:59 INFO - -d DEST, --destination=DEST 03:45:59 INFO - Directory to install application into. [default: 03:45:59 INFO - "/builds/slave/test"] 03:45:59 INFO - --app=APP Application being installed. [default: firefox] 03:45:59 INFO - mkdir: /builds/slave/test/build/application 03:45:59 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'] 03:45:59 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 03:46:40 INFO - Reading from file tmpfile_stdout 03:46:40 INFO - Output received: 03:46:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:46:40 INFO - Running post-action listener: _resource_record_post_action 03:46:40 INFO - ##### 03:46:40 INFO - ##### Running run-tests step. 03:46:40 INFO - ##### 03:46:40 INFO - Running pre-action listener: _resource_record_pre_action 03:46:40 INFO - Running main action method: run_tests 03:46:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:46:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:46:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:46:40 INFO - 2015-11-16 03:46:40.126 screenresolution[2791:22752] starting screenresolution argv=screenresolution get 03:46:40 INFO - 2015-11-16 03:46:40.129 screenresolution[2791:22752] Display 0: 1600x1200x32@60 03:46:40 INFO - 2015-11-16 03:46:40.137 screenresolution[2792:22754] starting screenresolution argv=screenresolution list 03:46:40 INFO - Available Modes on Display 0 03:46:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:46:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:46:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:46:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:46:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:46:40 INFO - Intel HD Graphics 3000: 03:46:40 INFO - Chipset Model: Intel HD Graphics 3000 03:46:40 INFO - Type: GPU 03:46:40 INFO - Bus: Built-In 03:46:40 INFO - VRAM (Total): 512 MB 03:46:40 INFO - VRAM (Dynamic, Max): 10 03:46:40 INFO - Vendor: Intel (0x8086) 03:46:40 INFO - Device ID: 0x0116 03:46:40 INFO - Revision ID: 0x0009 03:46:40 INFO - Displays: 03:46:40 INFO - Display: 03:46:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:46:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:46:40 INFO - Display Serial Number: 1600x1200 60 03:46:40 INFO - Main Display: Yes 03:46:40 INFO - Mirror: Off 03:46:40 INFO - Online: Yes 03:46:40 INFO - Rotation: Supported 03:46:40 INFO - Return code: 0 03:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:40 INFO - Python 2.7.3 03:46:40 INFO - Return code: 0 03:46:40 INFO - grabbing minidump binary from tooltool 03:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:40 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 0x1103e29f0>, '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 0x110142db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:40 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 03:46:40 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 03:46:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:40 INFO - Return code: 0 03:46:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:46:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:46:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:40 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/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0091', '--webServer', 'localhost'] in /builds/slave/test/build 03:46:40 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/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0091 --webServer localhost 03:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wllGRcsn6B/Render', 03:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:40 INFO - 'HOME': '/Users/cltbld', 03:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:40 INFO - 'LOGNAME': 'cltbld', 03:46:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:40 INFO - 'MOZ_NO_REMOTE': '1', 03:46:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:40 INFO - 'NO_EM_RESTART': '1', 03:46:40 INFO - 'PAGER': '/bin/cat', 03:46:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:40 INFO - 'PWD': '/builds/slave/test', 03:46:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:40 INFO - 'SHELL': '/bin/bash', 03:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8r1YdwNoDE/Listeners', 03:46:40 INFO - 'TMPDIR': '/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/', 03:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:40 INFO - 'USER': 'cltbld', 03:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:40 INFO - 'XPC_FLAGS': '0x0', 03:46:40 INFO - 'XPC_SERVICE_NAME': '0', 03:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:46:40 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/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0091', '--webServer', 'localhost'] with output_timeout 3600 03:46:40 INFO - mozversion INFO | application_buildid: 20151116025234 03:46:40 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 03:46:40 INFO - mozversion INFO | application_display_name: Nightly 03:46:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:40 INFO - mozversion INFO | application_name: Firefox 03:46:40 INFO - mozversion INFO | application_remotingname: firefox 03:46:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:46:40 INFO - mozversion INFO | application_vendor: Mozilla 03:46:40 INFO - mozversion INFO | application_version: 45.0a1 03:46:40 INFO - mozversion INFO | platform_buildid: 20151116025234 03:46:40 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 03:46:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:46:40 INFO - mozversion INFO | platform_version: 45.0a1 03:46:40 INFO - 2015-11-16 03:46:40,787 DEBUG : using testdate: 1447674400 03:46:40 INFO - 2015-11-16 03:46:40,787 DEBUG : actual date: 1447674400 03:46:40 INFO - 2015-11-16 03:46:40,886 INFO : starting webserver on 'localhost:50505' 03:46:40 INFO - 2015-11-16 03:46:40,888 INFO : Starting test suite t-yosemite-r5-0091 03:46:40 INFO - 2015-11-16 03:46:40,888 INFO : Starting test dromaeo_css 03:46:40 INFO - 2015-11-16 03:46:40,888 DEBUG : operating with platform_type : mac_ 03:46:40 INFO - 2015-11-16 03:46:40,889 INFO : Initialising browser for dromaeo_css test... 03:46:40 INFO - 2015-11-16 03:46:40,903 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpD468dN/profile http://localhost:50505/getInfo.html 03:46:43 INFO - 2015-11-16 03:46:43,427 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:46:43 INFO - 2015-11-16 03:46:43,427 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:46:43 INFO - 2015-11-16 03:46:43,427 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:46:43 INFO - 2015-11-16 03:46:43,428 DEBUG : BROWSER_OUTPUT: __metrics 03:46:43 INFO - 2015-11-16 03:46:43,444 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:46:44 INFO - 2015-11-16 03:46:44,210 INFO : Browser initialized. 03:46:44 INFO - 2015-11-16 03:46:44,211 INFO : Running cycle 1/1 for dromaeo_css test... 03:46:44 INFO - 2015-11-16 03:46:44,211 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpD468dN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:46:56 INFO - 2015-11-16 03:46:56,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 229150720 03:46:56 INFO - 2015-11-16 03:46:56,327 DEBUG : BROWSER_OUTPUT: 03:47:47 INFO - 2015-11-16 03:47:47,261 DEBUG : BROWSER_OUTPUT: 1447674467253 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] 03:49:58 INFO - 2015-11-16 03:49:58,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50505/tests/dromaeo/cssquery-ext.html) 03:49:59 INFO - 2015-11-16 03:49:59,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 335364096 03:49:59 INFO - 2015-11-16 03:49:59,626 DEBUG : BROWSER_OUTPUT: 03:53:02 INFO - 2015-11-16 03:53:02,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-ext.html (next: http://localhost:50505/tests/dromaeo/cssquery-jquery.html) 03:53:03 INFO - 2015-11-16 03:53:03,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 365969408 03:53:03 INFO - 2015-11-16 03:53:03,007 DEBUG : BROWSER_OUTPUT: 03:56:05 INFO - 2015-11-16 03:56:05,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50505/tests/dromaeo/cssquery-mootools.html) 03:56:05 INFO - 2015-11-16 03:56:05,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 341655552 03:56:05 INFO - 2015-11-16 03:56:05,837 DEBUG : BROWSER_OUTPUT: 03:59:07 INFO - 2015-11-16 03:59:07,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50505/tests/dromaeo/cssquery-prototype.html) 03:59:08 INFO - 2015-11-16 03:59:08,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 321613824 03:59:08 INFO - 2015-11-16 03:59:08,565 DEBUG : BROWSER_OUTPUT: 04:02:11 INFO - 2015-11-16 04:02:11,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50505/tests/dromaeo/cssquery-yui.html) 04:02:12 INFO - 2015-11-16 04:02:12,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 322789376 04:02:12 INFO - 2015-11-16 04:02:12,559 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/dromaeo/cssquery-yui.html (next: http://localhost:50505/tests/dromaeo/cssquery-dojo.html) 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 366186496 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:15 INFO - 2015-11-16 04:05:15,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:15 INFO - 2015-11-16 04:05:15,739 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2689.44866302408;2804.5372513535267;2828.7736981041494;2856.4572731181074;2859.899903503377;4561.315802629607;4587.334836448713;4621;4687.086018226447;4707.964247865469;4529.660275479336;4547.613452856503;4649.488556258809;4761.190597598408;4920.926186107211;4222.493300803908;4319.76241306728;4353.238183317922;4363.847265345714;4384.956150438503;4339.067100573376;4436.711613745097;4439.8446054388105;4501.819927202908;4545.409096817409;4245.766482843443;4372.737635741865;4382.824687012516;4425.5353187915125;4428.557144285578;4203.4115223868685;4320.330348795942;4356.869293921188;4365.563443655641;4373.475182978032;4337.436133302682;4340.023494713696;4420.602145806861;4439.911201775979;4449.822007119711;4516.322551617251;4715.669903106784;4716.2454007359;4730.432348118248;4807.61539076873;4868.9756551217015;4952.405711314629;4960.107180707471;4998.850034498971;5069.188929771219;5012.523810238058;5069.898602027975;5131.486851314876;5141.331626888518;5173.430922598511;4567.2920697291975;4711.575958163748;4712.151812673717;4730.739809310521;4754.334393184957;5177.870553236199;5194.68831870089;5239.895202096013;5260.631755777135;5286.022085914118;4976.62675299354;4978.6017118630425;5037.11850426174;5072.923906141411;5097.311862898536;4865.56209941107;4989.376327959005;5107.131787596118;5149.382074151126;5189.766460509286;4911.484294149134;4978.278149668277;5034.446210916796;5059.316992206079;5095.108356037753;4934.1118598651865;4990.351254336913;4996.625253106032;5021.899562008739;5023.2214006829;3767.2088861339425;3864.768113913174;3874.380099184117;3896.9610303897166;3932.0956180078742;3467.115885449194;3501.719862411052;3539.486774417695;3562.6793588576634;3628.8911332660064;4679.204535229019;4692.0850434165695;4721.268203428474;4738.099761045391;4768.856934291976;4884.267359895973;5024.773885175176;5031.144705400091;5102.948970510248;5127.53852153308;4679.485256621769;4724.905501889943;4791.209450440708;4818.6626936114835;4825.541573550507;4445.711028783118;4501.212287849678;4533.5013148553635;4563.634909207255;4564.383808185852;5248.422673505987;5305.70818604965;5334.59990500714;5348.78604855817;5382.138857782657;5022.397312322545;5040.521150490697;5075.6193285502995;5090.389153301628;5123.718195499283;5286.180642000496;5333.359996800254;5350.946490535045;5356.919646205232;5401.459854014567;4778.904421911612;4985.451600324034;5010.974945125251;5036.597072234139;5118.948810511996;4969.378827646544;4985.675931064469;4996.375453068366;5005.149124648891;5078.136716758234;4925.310456536016;4939.357883475269;4979.253112033224;4980.477049909852;5002.174641184164;4801.7118972861745;4842.709437433765;4870.464248932685;5007.223880298559;5014.84955451337;4772.785224664968;4840.2255639097575;4892.266160075875;4916.213405855046;4929.16204245272;4985.326980857682;5005.549500544968;5021.322121513549;5026.824061157842;5044.571211447068;4808.519148085304;4913.238448040559;4946.8763280918265;4952.653314267966;4958 04:05:15 INFO - 2015-11-16 04:05:15,739 DEBUG : BROWSER_OUTPUT: |1;ext.html;493.1640868727507;493.4621262823522;501.10552663495645;510.8952664703735;531.8165232994616;27480;28869.278268043283;33917.99999999997;34576.999999999935;34756.47865282023;36610.450843237304;36831.81584092076;37426.62573374266;37450;37455;7354.963225183867;7881.842363152734;7983.880241796378;7987.96006019972;8055.718049868256;7237.348638622523;9813.411195328268;9992.100710936014;10001.599936002587;10023.198144148488;9558.330916835825;9790.510474476283;9791.510424478784;9796.70609881701;9827.213822894188;7282.198958114604;7459.030326057632;7486.326230639214;9617.23062155026;9883.357581757164;9801.607935682565;9809.558569864374;9954;9961.75095622608;9986.800263994752;35638.8218058908;35714.28571428557;35853.28293434143;35967;36155.81922090399;2632.921012369632;2690.5651379063584;2714.5928110783343;2925.1224632610347;2952.896648617288;23760.524789504114;23960.400989975216;24066.15768448096;24519.38701532458;24894.37764055895;2100.1074543319028;2113.2075471698113;2120.5758848230416;2157.4390658428765;2164.404788683109;239097;241838;242273;242790.7860460704;245632;45775.77112114418;52387.738061310214;52669.73665131727;53210;53350;44353.77823110928;44457.33314000293;62298.68850655809;62606.61753677199;62739;12989;13110.803337949937;13149.737005259842;13177.47290108385;13304.866951330363;9911.504424778876;9920.305578609428;9922.255830812717;9929.851052234222;10008.199344052458;17390.565235869206;17508.037057961934;17620.823791762174;17633.55916102082;17678.204480798395;7225.8554828903125;7246.891296630555;7282.453815963824;7293.562386256735;7391.708570343211;826.4586695714197;865.2688478235881;890.1632465482426;929.312308891429;1005.2711783956573;22772.31683049511;24306.392340191636;24341.878290608434;24386.146484872945;24393.512129757306;902.4404868981143;908.5457271364318;908.7591788176006;916.4272329793879;918.3433844801;12624.55814046504;12707.618771436872;12734.61796146117;12738;12743.936280318725;278691;286433;286471;288209;291596;46916.5308346919;47120.7643961778;47180.5281947183;47181;48001.75999120052;1007.5818535307765;1089.4334945828125;1091.5415525479318;1193.9283642981275;1345.9865401346253;23777;24841.627375589018;25486.490270194863;25831;25983.740162598133;44091.55908440874;45536.999999998676;45840.54159458496;45916.311255331864;46132.769336154444;329952;330398;382890;392436;395134;27132.186034419;27437.17688469349;27475.31311717223;27489.31276718098;27652.308692282855;37167.62832371642;37593.62406376011;37913.24173516569;38237.426438604;38299.425508616834;31481.21296967594;32091.6790832098;32250.516242255915;32336.191595210308;32733.836330818194;31259.374812504077;31489.21276968094;31539.36921261608;31554.842225788725;32019.35961280808;31542.211444713146;32343;32344.83827580847;32410.35179296448;33005.17487062843;24851.00595976213;27552.86223568869;27704.86147569249;27993.72006279911;28022.579661304688;21130.78869211288;21173.364799056053;21219.575608488052;21226.575468490853;21305.86941305857 04:05:15 INFO - 2015-11-16 04:05:15,739 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.3845305631647;298.9805662631929;299.6853304030767;308.17101995631737;310.6536212123482;13013.934930325335;13437.731245375087;14640.633984150401;15596.766048509282;15862.84137158628;10285.845712314303;10631.734206644818;10786.137109031279;13449.731005379886;15741.370345186178;3422.315536892625;3947.1908258806875;3984.5019372578427;4001.399790031504;4001.779902105383;2981.8658160382834;3117.0492999635103;3803.9809800950957;4016.7188296819236;4120.052387950773;4119.320312148492;4148.543660197391;4231.957680423203;4234.9364759528635;4238.894027649318;4133.731307465006;4145.253854306239;4178.519470260898;4200.936985945214;4217.536071032184;3506.140995456104;3566.946495802565;3575.606683264839;3624.27514497099;3629.4737263096968;11349;11568.363739994296;11577.189596728233;11781.58764443249;11841.40792960357;1616.8544830965152;1633.2568681250123;1674.4558018643868;1691;1691.4164613208548;8223.095459499451;8540.359473039547;8624.094470080614;8625.611847466816;8792.8681069784;1372.27955323455;1390.478570536049;1412.1103704665995;1457.0674768148394;1467.4350375105662;48994.51005489935;50568;51136;51359.486405135845;51803.48196518024;5722.885542289131;5745.540356771448;5756.65460072397;5805.187273781589;5840.328362238312;6542.411182993458;6643.800685979429;6644.900326495106;6647.368499992493;6647.734090636417;4578.381918441034;4588.7935042923145;4591.816327346935;4604.930926036112;4629.699069560468;4528.47922488918;4571.9085618287445;4606.470255920545;4672.859814205579;4841.564259216617;2606.153000274918;2608.9347766305614;2615.1500762251962;2635.934101647436;2658.9069382571515;900.320258205051;904.5386852705168;910.4491782471641;918.6233644205977;938.3244064273712;306.82051000165154;349.1637528120138;358.62702789099046;361.41090023261916;365.493791099324;9411.341206115643;9822.901770982198;9915.900840991499;9953.601855925683;9994.450305233137;349.9370113379616;379.94870692456715;380.708757800283;381.3517021064202;397.4733478141474;4636.5131661175765;5383.569314454834;5425.240466334716;5429.484199001088;5442.455754424526;460311;461160;463292;464639;465119;56467.89426581495;62814;64482.355176448575;64590.35409645937;64768.35231647623;427.77541790560207;431.88986808363666;434.95867892550154;437.55806635297944;440.4692345723396;9513.286503512127;9523.857142142735;9571.1864491519;9613.375130616487;9723.416595004039;29009.274768130967;29598.704012959595;30477.390452191277;30944.690553095083;30956.142631442184;39643.405348920365;40056.79971600123;40631.7968410156;40904.181916362104;41083.7945810269;5350.759215835219;5364.839054828361;5369.19462080691;5401.756920938646;5415.160650099241;9362.719118426457;9625.614975401186;9687.176589989647;9690.854637180308;10247.7438064049;7281.672324745293;7472.589007604634;8041.517508949481;8403.95798021006;8643.87034194475;7952.284294413531;8229.382796290183;8340.87488687658;8484.278836298983;8539.957300213458;8803.119688031145;8872.911270887209;8939.776505587151;9055.230305424113;9118.088191181094;13364.131331463424;13412.731745365234;13489.460421583026;13773.173609583457;13911.373988170355;13333.266670332836;13502.122362046435;13746.175229485863;13843;13986.650333741738 04:05:15 INFO - 2015-11-16 04:05:15,739 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1195.3365881935522;1511.2896938438932;1563.1012168003397;1600.5118438876145;1611.6132128289207;6286;6736.259011508736;6869.862602747949;7001.474889383291;7017.368436840683;6979.267176946424;7031;7043.929560704404;7123.216446190915;7132.821679458016;2028.7261219735294;2037.5313677854103;2042.0912693851205;2065.483629092727;2066.380085974209;2054.969175462369;2069.813716765491;2078.833693304532;2091.1530830013867;2096.2139197800825;2023.0794988280297;2023.5952809438097;2034.4812072921459;2036.9287074952379;2055.4142069510194;2043.38698390483;2046.6418376784004;2059.4027731957713;2066.71066050753;2071.585682863426;2025.767036790773;2037.602667479842;2050.4258807533765;2052.138101997165;2064.298138632872;6232.1898153240245;7004.92995070053;7050.118735158106;7093.077899873035;7143.464240182007;4059.411385349137;4140.855070072533;4363.36731173978;4549.522300158469;4567.3377360282575;2609.712931577525;2622.960655590168;2706.512827691015;2707.2284398946404;2724.8365098093977;689.2693744630708;846.6909578004046;848.2662496940164;870.0994470722771;879.7580665317025;8937.240334571634;9006.099390061006;9174.174324310845;9175.816483670356;9190.035046320174;3884.6115388460926;3917.51134568862;3932.7050471214775;3955.4857868476915;4223.852165174204;8260.463069900437;8264.669413223404;8279.254867061993;8281.668733250603;8285.792855178548;4536.7731613419855;4599.33309670096;4602.493725690171;4602.562756538124;4615.2384856498975;4065.4511640928686;4102.405151253051;4115.403266526337;4158.022864626811;4161.687873409506;3364.0580637421563;3382.9661703383144;3384.915377115592;3469.8612055518;3480.965190348115;1090.5801266512449;1095.8794532601407;1102.0522350778324;1109.8612673415823;1116.5143162724241;928.9303302252358;944.7968686732386;961.4952150121243;998.8501724741346;1151.240181480219;6727.9327206728285;6793.218779840283;6801.387875091265;6822.829429264308;6823.044773731682;410.25948163564453;411.87437831461693;412.81835992163354;432.0128506363008;433.9262325404689;5291.153415453509;5299.178627312773;5342.305500284938;5354.571634269327;5361;8043;8350.874736878952;8472.576371181416;8590.398672092893;8606.526641034803;8350.33197344211;8385.245327920395;8388.748337549883;8395.118512556215;8437.198466145706;5996.520278377807;6377.57652092202;6531.3142120077655;6666.166729158856;6762.087118239073;6285.2457705075685;6361.395667411589;6592.80221593353;6614.140161779131;6620.900686489803;6849.1096157499205;6974.058502102152;7251.41988640918;7494.925050749423;7546.622668866425;7537.057867766529;7695.345895598713;7750.341220996053;7779.961100194463;7852.725154619561;6315.96842015787;6318.557700960889;6405.0392441132335;6405.3594640535575;6415.647139407378;6785.457163426815;6851.45188384918;6897.7585784497305;6906.723731050903;6907.13660792401;6211.689415529115;6329.683515824098;6343.904841427475;6350.364963503797;6454.19322584677;6229.408206220402;6252.468540173954;6354.618722876642;6411.4229719325485;6421.743130274924;6147.84630384244;6329.367063293634;6340.587861788969;6373.713182906873;6422.3577642235405;5828.883422331445;5849.707514624337;5866.2960444746905;5902.4097590240635;5932.79235226765;5886.793962211302;5964.224650795369;6017.06735456005;6038.033914573647;6044.727987240497 04:05:15 INFO - 2015-11-16 04:05:15,739 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.8343077584225;284.61718987961183;287.4007693958096;289.40671623172506;289.70450140856343;5534.723263836807;5538.676793923643;5592.804251851186;5606.691631960241;5613.719314034297;5512.4211957744465;5543.750531226095;5545.944540554593;5573.247611572437;5601.719914004294;4215.747055176684;4236.512801027875;4255.234057869582;4263.232618128735;4275.444192255002;4203.054312779631;4260.786960651971;4267.359896015591;4269.188854117708;4280.59334363235;3995.8801235962824;4045.4134150548152;4159.812808423613;4164.167166566699;4231.87304380869;4184.246835569596;4228.238916994939;4233.25917964355;4240.1307731914885;4271.1671224111315;3592.497050412944;3613.4218525035867;3615.439606860941;3632.745707800455;3647.726420518445;5190;5259.921101183485;5274.182501712241;5337.386200586943;5409.648372855791;4676.55572720591;4757.0723708876785;4798.04039192163;4798.592119669832;4816.229403295456;5800.593958422912;5817.069268916953;5864.266966629171;5901.17383566301;5901.734421951022;3924.2543916655745;3927.88216353507;3989.840406383741;3991.1818077294083;3994.141259629165;5814.273215848019;6078.9088163678025;6152.692365381713;6167.198264225667;6171.691415429255;3905.921881562353;3906.199229158016;3953.7034722395933;3961.3463778476803;3979.6816254699556;3956.2878681837547;3994.46074779901;4055.9594404055583;4118.135191609736;4119.7940102994735;4717.693349932243;4738.407699037621;4799.592034677092;4804.9669321096135;4810.6151507879285;5678.545716342683;5802.245708057925;5803.100519419497;5855.3266374367495;5855.824325270249;1434.0606902478894;1445.284584130862;1445.869871711551;1446.768517037269;1461.101422625078;932.5383934952107;938.5307346326837;943.6225509796136;944.1078181118914;960.7454024683465;5600.971995140079;5673.546116310686;5676.035074037423;5681.801136960186;5692.089265717465;5993.61041532299;5995.52035837132;6106.938930610726;6108.267007958984;6116.816495505142;5629.802956896489;5635.182898479779;5673.631213971079;5674.546036317085;5687.914681279784;3172.809631422122;3259.543663887058;3263.118957881406;3266.5426840242385;3318.8672453101603;6304.968475157595;6340.080688300171;6353.205849268841;6354.777582784581;6378.553501254868;6147.293061298008;6223.844403889939;6234.220722409699;6246.656433896179;6270.122182894398;6084.117802918552;6313.936860631335;6355.586886852339;6362.0774987627465;6386;6062.120992455981;6072.514198864169;6082.6046306991675;6093.451589356979;6106.816795496142;5878.882422351444;5938.792142275172;5949.702514874152;5964.761409543569;5967.940320596912;6112.083187521907;6346.904796427965;6349.0476428536085;6361.363863613602;6372.490200783834;3968.087339911894;4024.2353952748886;4032.91934161321;4046.838126474908;4070.9796451017555;6032.155498230163;6088.056351265561;6094.481969032682;6097;6103.08453731926;5902.704864756831;5905.320888097752;5917.319508256605;5923.970380148244;5940.495057920125;5772.855678608068;5821.505172060253;5884.735186916685;5893.941060589511;5972.70136493165;5689.516391106802;5810.970945145247;5837.474627283395;5844.12338149281;5851;5843.970780146072;5854.619449735754;5855.121731740273;5946.524278057658;5963.9105413417965;5673.631213971244;5729.255196824386;5765.106408506688;5829.737661805314;5838.708064596668 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: |5;yui.html;667.5494041521971;675.3010633993817;678.9388954994052;688.8553403785205;695.8956156576514;12318.81521777173;12381.442835072421;12584.244945303266;12591.811122833165;12611.43248553815;11455.198136130473;11513.251638643482;11591.6522504325;11596.710082247948;11605.3036817791;615.2985596420085;636.7962252079336;737.3069314844056;767.4014268870291;797.3182928596054;778.8014056415634;784.4704824243641;790.7983464216617;791.4143533785016;800.1878093734864;818.664347617477;819.2994989284166;827.4208054361941;829.1045670675655;833.4499230507867;646.5474168082337;653.3564439027554;654.8199245207559;809.9392545559107;830.2486249943811;620.0791824141147;620.2494981072907;621.546271222006;622.7851391270004;623.0840664223584;10495.42275174865;10497;10541.578336866516;10557.313774604627;10643.0421262086;10125.696229113139;10192.184625229964;10447.582096716122;11041.889581104166;11107.222494425394;8385;8447.408681392244;8456.365772567082;8493.320534357237;8898.42160259581;2962.9407411851644;3034.332446861687;3076.2463196516997;3089.5056790913345;3132.15431833406;43237.78381108074;44424.11151776947;44520.3321950171;44621.55378446206;44637.77681111606;7964.203579642105;8125.95937020323;8132.146124656944;8394.328453723687;8661.090585488559;17140;17141.657166856843;17146.05696686694;17203.13984300805;17319.826801731822;6290.716917738713;6355.745770169141;6474.838129046811;6540.117084193668;6623.701933413008;3437.2781715839956;3534.3814832404228;3569.0720412692885;3614.042278796121;3720.795356255432;2634.3414146463383;2668.5730283154603;2669.4394177223003;2670.452557225764;2677.8259413138085;391.6925213707283;396.20363070229047;483.91773398521633;501.15305134322875;505.48440590597386;478.7917255993584;521.8304051183304;531.3066448285025;538.8087229033715;547.479894100606;7055.259197784261;7265.452456645921;7321.377682896907;7460.552366857897;7567.9243207568325;365.2366553902357;434.92823684092406;468.94841567427557;490.6859609849699;553.8864532770772;3250.431174544445;3431.4166591679473;3512.9121771955392;3573.5711714594413;3651.087228192952;48241;48428.75785621049;48653.270200947016;48671;48753.268700969515;43115.56884431178;45687.771561141984;45919;45932.311015334795;46106;39042;39864.800675997016;41362.379564307164;41938;42040.78979605083;7117.252688467636;7200.279972002758;7500.012402454763;7540.9622951884885;7618.847623047619;29407;29854.552181717725;31329.06012819619;31503.21241968969;31505.8424707875;38183.61816381912;38505.422418664304;38773.80613096916;41070.66081409517;41178.79410602928;6595.307492713196;6804.813501772765;6958.304169583002;6959.478039147186;7139.428845692229;9834.75413114678;9904.108630223314;10023.799524009624;10132.493375331056;10464;9157.267418606361;9357.672481463389;9436.669716559887;9552.522373881138;10098.697039088838;9825.656102036395;9898.554565044735;9909.504524773589;10109.241806864367;10665;9677.70966870995;9689.22486201088;9795.706128816148;9812.656557020755;9912.752181195528;8226.753197403848;8241.917580824114;8801.38390312672;8885;8892.199702026848;7619.9238007619215;8145;8151.266386025286;8277.751667449986;8506.574671266535 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:15 INFO - 2015-11-16 04:05:15,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1447675515728__endTimestamp 04:05:15 INFO - 2015-11-16 04:05:15,742 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:15 INFO - 2015-11-16 04:05:15,742 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:15 INFO - 2015-11-16 04:05:15,742 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,742 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4716.90 Median:4870.46 stddev:518.09 (10.6%) stddev-sans-first:494.67 04:05:15 INFO - 2015-11-16 04:05:15,743 DEBUG : BROWSER_OUTPUT: Values: 2689.4 2804.5 2828.8 2856.5 2859.9 4561.3 4587.3 4621.0 4687.1 4708.0 4529.7 4547.6 4649.5 4761.2 4920.9 4222.5 4319.8 4353.2 4363.8 4385.0 4339.1 4436.7 4439.8 4501.8 4545.4 4245.8 4372.7 4382.8 4425.5 4428.6 4203.4 4320.3 4356.9 4365.6 4373.5 4337.4 4340.0 4420.6 4439.9 4449.8 4516.3 4715.7 4716.2 4730.4 4807.6 4869.0 4952.4 4960.1 4998.9 5069.2 5012.5 5069.9 5131.5 5141.3 5173.4 4567.3 4711.6 4712.2 4730.7 4754.3 5177.9 5194.7 5239.9 5260.6 5286.0 4976.6 4978.6 5037.1 5072.9 5097.3 4865.6 4989.4 5107.1 5149.4 5189.8 4911.5 4978.3 5034.4 5059.3 5095.1 4934.1 4990.4 4996.6 5021.9 5023.2 3767.2 3864.8 3874.4 3897.0 3932.1 3467.1 3501.7 3539.5 3562.7 3628.9 4679.2 4692.1 4721.3 4738.1 4768.9 4884.3 5024.8 5031.1 5102.9 5127.5 4679.5 4724.9 4791.2 4818.7 4825.5 4445.7 4501.2 4533.5 4563.6 4564.4 5248.4 5305.7 5334.6 5348.8 5382.1 5022.4 5040.5 5075.6 5090.4 5123.7 5286.2 5333.4 5350.9 5356.9 5401.5 4778.9 4985.5 5011.0 5036.6 5118.9 4969.4 4985.7 4996.4 5005.1 5078.1 4925.3 4939.4 4979.3 4980.5 5002.2 4801.7 4842.7 4870.5 5007.2 5014.8 4772.8 4840.2 4892.3 4916.2 4929.2 4985.3 5005.5 5021.3 5026.8 5044.6 4808.5 4913.2 4946.9 4952.7 4958.0 04:05:15 INFO - 2015-11-16 04:05:15,744 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,744 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44356.10 Median:181478.59 stddev:79822.70 (44.0%) stddev-sans-first:79978.69 04:05:15 INFO - 2015-11-16 04:05:15,745 DEBUG : BROWSER_OUTPUT: Values: 493.2 493.5 501.1 510.9 531.8 27480.0 28869.3 33918.0 34577.0 34756.5 36610.5 36831.8 37426.6 37450.0 37455.0 7355.0 7881.8 7983.9 7988.0 8055.7 7237.3 9813.4 9992.1 10001.6 10023.2 9558.3 9790.5 9791.5 9796.7 9827.2 7282.2 7459.0 7486.3 9617.2 9883.4 9801.6 9809.6 9954.0 9961.8 9986.8 35638.8 35714.3 35853.3 35967.0 36155.8 2632.9 2690.6 2714.6 2925.1 2952.9 23760.5 23960.4 24066.2 24519.4 24894.4 2100.1 2113.2 2120.6 2157.4 2164.4 239097.0 241838.0 242273.0 242790.8 245632.0 45775.8 52387.7 52669.7 53210.0 53350.0 44353.8 44457.3 62298.7 62606.6 62739.0 12989.0 13110.8 13149.7 13177.5 13304.9 9911.5 9920.3 9922.3 9929.9 10008.2 17390.6 17508.0 17620.8 17633.6 17678.2 7225.9 7246.9 7282.5 7293.6 7391.7 826.5 865.3 890.2 929.3 1005.3 22772.3 24306.4 24341.9 24386.1 24393.5 902.4 908.5 908.8 916.4 918.3 12624.6 12707.6 12734.6 12738.0 12743.9 278691.0 286433.0 286471.0 288209.0 291596.0 46916.5 47120.8 47180.5 47181.0 48001.8 1007.6 1089.4 1091.5 1193.9 1346.0 23777.0 24841.6 25486.5 25831.0 25983.7 44091.6 45537.0 45840.5 45916.3 46132.8 329952.0 330398.0 382890.0 392436.0 395134.0 27132.2 27437.2 27475.3 27489.3 27652.3 37167.6 37593.6 37913.2 38237.4 38299.4 31481.2 32091.7 32250.5 32336.2 32733.8 31259.4 31489.2 31539.4 31554.8 32019.4 31542.2 32343.0 32344.8 32410.4 33005.2 24851.0 27552.9 27704.9 27993.7 28022.6 21130.8 21173.4 21219.6 21226.6 21305.9 04:05:15 INFO - 2015-11-16 04:05:15,745 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,745 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23202.10 Median:2333.33 stddev:75795.88 (3248.4%) stddev-sans-first:75988.98 04:05:15 INFO - 2015-11-16 04:05:15,747 DEBUG : BROWSER_OUTPUT: Values: 292.4 299.0 299.7 308.2 310.7 13013.9 13437.7 14640.6 15596.8 15862.8 10285.8 10631.7 10786.1 13449.7 15741.4 3422.3 3947.2 3984.5 4001.4 4001.8 2981.9 3117.0 3804.0 4016.7 4120.1 4119.3 4148.5 4232.0 4234.9 4238.9 4133.7 4145.3 4178.5 4200.9 4217.5 3506.1 3566.9 3575.6 3624.3 3629.5 11349.0 11568.4 11577.2 11781.6 11841.4 1616.9 1633.3 1674.5 1691.0 1691.4 8223.1 8540.4 8624.1 8625.6 8792.9 1372.3 1390.5 1412.1 1457.1 1467.4 48994.5 50568.0 51136.0 51359.5 51803.5 5722.9 5745.5 5756.7 5805.2 5840.3 6542.4 6643.8 6644.9 6647.4 6647.7 4578.4 4588.8 4591.8 4604.9 4629.7 4528.5 4571.9 4606.5 4672.9 4841.6 2606.2 2608.9 2615.2 2635.9 2658.9 900.3 904.5 910.4 918.6 938.3 306.8 349.2 358.6 361.4 365.5 9411.3 9822.9 9915.9 9953.6 9994.5 349.9 379.9 380.7 381.4 397.5 4636.5 5383.6 5425.2 5429.5 5442.5 460311.0 461160.0 463292.0 464639.0 465119.0 56467.9 62814.0 64482.4 64590.4 64768.4 427.8 431.9 435.0 437.6 440.5 9513.3 9523.9 9571.2 9613.4 9723.4 29009.3 29598.7 30477.4 30944.7 30956.1 39643.4 40056.8 40631.8 40904.2 41083.8 5350.8 5364.8 5369.2 5401.8 5415.2 9362.7 9625.6 9687.2 9690.9 10247.7 7281.7 7472.6 8041.5 8404.0 8643.9 7952.3 8229.4 8340.9 8484.3 8540.0 8803.1 8872.9 8939.8 9055.2 9118.1 13364.1 13412.7 13489.5 13773.2 13911.4 13333.3 13502.1 13746.2 13843.0 13986.7 04:05:15 INFO - 2015-11-16 04:05:15,747 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,747 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4924.65 Median:6242.33 stddev:2535.85 (40.6%) stddev-sans-first:2527.47 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: Values: 1195.3 1511.3 1563.1 1600.5 1611.6 6286.0 6736.3 6869.9 7001.5 7017.4 6979.3 7031.0 7043.9 7123.2 7132.8 2028.7 2037.5 2042.1 2065.5 2066.4 2055.0 2069.8 2078.8 2091.2 2096.2 2023.1 2023.6 2034.5 2036.9 2055.4 2043.4 2046.6 2059.4 2066.7 2071.6 2025.8 2037.6 2050.4 2052.1 2064.3 6232.2 7004.9 7050.1 7093.1 7143.5 4059.4 4140.9 4363.4 4549.5 4567.3 2609.7 2623.0 2706.5 2707.2 2724.8 689.3 846.7 848.3 870.1 879.8 8937.2 9006.1 9174.2 9175.8 9190.0 3884.6 3917.5 3932.7 3955.5 4223.9 8260.5 8264.7 8279.3 8281.7 8285.8 4536.8 4599.3 4602.5 4602.6 4615.2 4065.5 4102.4 4115.4 4158.0 4161.7 3364.1 3383.0 3384.9 3469.9 3481.0 1090.6 1095.9 1102.1 1109.9 1116.5 928.9 944.8 961.5 998.9 1151.2 6727.9 6793.2 6801.4 6822.8 6823.0 410.3 411.9 412.8 432.0 433.9 5291.2 5299.2 5342.3 5354.6 5361.0 8043.0 8350.9 8472.6 8590.4 8606.5 8350.3 8385.2 8388.7 8395.1 8437.2 5996.5 6377.6 6531.3 6666.2 6762.1 6285.2 6361.4 6592.8 6614.1 6620.9 6849.1 6974.1 7251.4 7494.9 7546.6 7537.1 7695.3 7750.3 7780.0 7852.7 6316.0 6318.6 6405.0 6405.4 6415.6 6785.5 6851.5 6897.8 6906.7 6907.1 6211.7 6329.7 6343.9 6350.4 6454.2 6229.4 6252.5 6354.6 6411.4 6421.7 6147.8 6329.4 6340.6 6373.7 6422.4 5828.9 5849.7 5866.3 5902.4 5932.8 5886.8 5964.2 6017.1 6038.0 6044.7 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4889.63 Median:5674.09 stddev:1507.72 (26.6%) stddev-sans-first:1471.73 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: Values: 280.8 284.6 287.4 289.4 289.7 5534.7 5538.7 5592.8 5606.7 5613.7 5512.4 5543.8 5545.9 5573.2 5601.7 4215.7 4236.5 4255.2 4263.2 4275.4 4203.1 4260.8 4267.4 4269.2 4280.6 3995.9 4045.4 4159.8 4164.2 4231.9 4184.2 4228.2 4233.3 4240.1 4271.2 3592.5 3613.4 3615.4 3632.7 3647.7 5190.0 5259.9 5274.2 5337.4 5409.6 4676.6 4757.1 4798.0 4798.6 4816.2 5800.6 5817.1 5864.3 5901.2 5901.7 3924.3 3927.9 3989.8 3991.2 3994.1 5814.3 6078.9 6152.7 6167.2 6171.7 3905.9 3906.2 3953.7 3961.3 3979.7 3956.3 3994.5 4056.0 4118.1 4119.8 4717.7 4738.4 4799.6 4805.0 4810.6 5678.5 5802.2 5803.1 5855.3 5855.8 1434.1 1445.3 1445.9 1446.8 1461.1 932.5 938.5 943.6 944.1 960.7 5601.0 5673.5 5676.0 5681.8 5692.1 5993.6 5995.5 6106.9 6108.3 6116.8 5629.8 5635.2 5673.6 5674.5 5687.9 3172.8 3259.5 3263.1 3266.5 3318.9 6305.0 6340.1 6353.2 6354.8 6378.6 6147.3 6223.8 6234.2 6246.7 6270.1 6084.1 6313.9 6355.6 6362.1 6386.0 6062.1 6072.5 6082.6 6093.5 6106.8 5878.9 5938.8 5949.7 5964.8 5967.9 6112.1 6346.9 6349.0 6361.4 6372.5 3968.1 4024.2 4032.9 4046.8 4071.0 6032.2 6088.1 6094.5 6097.0 6103.1 5902.7 5905.3 5917.3 5924.0 5940.5 5772.9 5821.5 5884.7 5893.9 5972.7 5689.5 5811.0 5837.5 5844.1 5851.0 5844.0 5854.6 5855.1 5946.5 5963.9 5673.6 5729.3 5765.1 5829.7 5838.7 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: 04:05:15 INFO - 2015-11-16 04:05:15,749 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11980.95 Median:513.66 stddev:14094.87 (2744.0%) stddev-sans-first:14108.80 04:05:15 INFO - 2015-11-16 04:05:15,751 DEBUG : BROWSER_OUTPUT: Values: 667.5 675.3 678.9 688.9 695.9 12318.8 12381.4 12584.2 12591.8 12611.4 11455.2 11513.3 11591.7 11596.7 11605.3 615.3 636.8 737.3 767.4 797.3 778.8 784.5 790.8 791.4 800.2 818.7 819.3 827.4 829.1 833.4 646.5 653.4 654.8 809.9 830.2 620.1 620.2 621.5 622.8 623.1 10495.4 10497.0 10541.6 10557.3 10643.0 10125.7 10192.2 10447.6 11041.9 11107.2 8385.0 8447.4 8456.4 8493.3 8898.4 2962.9 3034.3 3076.2 3089.5 3132.2 43237.8 44424.1 44520.3 44621.6 44637.8 7964.2 8126.0 8132.1 8394.3 8661.1 17140.0 17141.7 17146.1 17203.1 17319.8 6290.7 6355.7 6474.8 6540.1 6623.7 3437.3 3534.4 3569.1 3614.0 3720.8 2634.3 2668.6 2669.4 2670.5 2677.8 391.7 396.2 483.9 501.2 505.5 478.8 521.8 531.3 538.8 547.5 7055.3 7265.5 7321.4 7460.6 7567.9 365.2 434.9 468.9 490.7 553.9 3250.4 3431.4 3512.9 3573.6 3651.1 48241.0 48428.8 48653.3 48671.0 48753.3 43115.6 45687.8 45919.0 45932.3 46106.0 39042.0 39864.8 41362.4 41938.0 42040.8 7117.3 7200.3 7500.0 7541.0 7618.8 29407.0 29854.6 31329.1 31503.2 31505.8 38183.6 38505.4 38773.8 41070.7 41178.8 6595.3 6804.8 6958.3 6959.5 7139.4 9834.8 9904.1 10023.8 10132.5 10464.0 9157.3 9357.7 9436.7 9552.5 10098.7 9825.7 9898.6 9909.5 10109.2 10665.0 9677.7 9689.2 9795.7 9812.7 9912.8 8226.8 8241.9 8801.4 8885.0 8892.2 7619.9 8145.0 8151.3 8277.8 8506.6 04:05:15 INFO - 2015-11-16 04:05:15,751 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:15 INFO - 2015-11-16 04:05:15,751 DEBUG : BROWSER_OUTPUT: 04:05:16 INFO - 2015-11-16 04:05:16,416 INFO : Browser exited with error code: 0 04:05:16 INFO - 2015-11-16 04:05:16,446 INFO : Completed test dromaeo_css (00:18:35) 04:05:16 INFO - 2015-11-16 04:05:16,446 INFO : Starting test kraken 04:05:16 INFO - 2015-11-16 04:05:16,446 DEBUG : operating with platform_type : mac_ 04:05:16 INFO - 2015-11-16 04:05:16,446 INFO : Initialising browser for kraken test... 04:05:16 INFO - 2015-11-16 04:05:16,461 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpg_GB1c/profile http://localhost:50505/getInfo.html 04:05:19 INFO - 2015-11-16 04:05:19,116 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:19 INFO - 2015-11-16 04:05:19,116 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:19 INFO - 2015-11-16 04:05:19,116 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:05:19 INFO - 2015-11-16 04:05:19,116 DEBUG : BROWSER_OUTPUT: __metrics 04:05:19 INFO - 2015-11-16 04:05:19,132 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:19 INFO - 2015-11-16 04:05:19,929 INFO : Browser initialized. 04:05:19 INFO - 2015-11-16 04:05:19,929 INFO : Running cycle 1/1 for kraken test... 04:05:19 INFO - 2015-11-16 04:05:19,929 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpg_GB1c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:05:32 INFO - 2015-11-16 04:05:32,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 228175872 04:05:32 INFO - 2015-11-16 04:05:32,051 DEBUG : BROWSER_OUTPUT: 04:05:34 INFO - 2015-11-16 04:05:34,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50505/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:35 INFO - 2015-11-16 04:05:35,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 285429760 04:05:35 INFO - 2015-11-16 04:05:35,326 DEBUG : BROWSER_OUTPUT: 04:05:38 INFO - 2015-11-16 04:05:38,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50505/tests/kraken/driver.html?testName=audio-dft) 04:05:38 INFO - 2015-11-16 04:05:38,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 298475520 04:05:38 INFO - 2015-11-16 04:05:38,915 DEBUG : BROWSER_OUTPUT: 04:05:42 INFO - 2015-11-16 04:05:42,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50505/tests/kraken/driver.html?testName=audio-fft) 04:05:42 INFO - 2015-11-16 04:05:42,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 284065792 04:05:42 INFO - 2015-11-16 04:05:42,765 DEBUG : BROWSER_OUTPUT: 04:05:44 INFO - 2015-11-16 04:05:44,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50505/tests/kraken/driver.html?testName=audio-oscillator) 04:05:45 INFO - 2015-11-16 04:05:45,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 285138944 04:05:45 INFO - 2015-11-16 04:05:45,542 DEBUG : BROWSER_OUTPUT: 04:05:47 INFO - 2015-11-16 04:05:47,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50505/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:48 INFO - 2015-11-16 04:05:48,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 285728768 04:05:48 INFO - 2015-11-16 04:05:48,525 DEBUG : BROWSER_OUTPUT: 04:05:51 INFO - 2015-11-16 04:05:51,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50505/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:52 INFO - 2015-11-16 04:05:52,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 284499968 04:05:52 INFO - 2015-11-16 04:05:52,507 DEBUG : BROWSER_OUTPUT: 04:05:55 INFO - 2015-11-16 04:05:55,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50505/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:56 INFO - 2015-11-16 04:05:56,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 281542656 04:05:56 INFO - 2015-11-16 04:05:56,571 DEBUG : BROWSER_OUTPUT: 04:05:59 INFO - 2015-11-16 04:05:59,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50505/tests/kraken/driver.html?testName=json-parse-financial) 04:06:00 INFO - 2015-11-16 04:06:00,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 283172864 04:06:00 INFO - 2015-11-16 04:06:00,344 DEBUG : BROWSER_OUTPUT: 04:06:02 INFO - 2015-11-16 04:06:02,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50505/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:02 INFO - 2015-11-16 04:06:02,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 316960768 04:06:02 INFO - 2015-11-16 04:06:02,604 DEBUG : BROWSER_OUTPUT: 04:06:04 INFO - 2015-11-16 04:06:04,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:05 INFO - 2015-11-16 04:06:05,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 318857216 04:06:05 INFO - 2015-11-16 04:06:05,240 DEBUG : BROWSER_OUTPUT: 04:06:07 INFO - 2015-11-16 04:06:07,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:08 INFO - 2015-11-16 04:06:08,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 325808128 04:06:08 INFO - 2015-11-16 04:06:08,132 DEBUG : BROWSER_OUTPUT: 04:06:11 INFO - 2015-11-16 04:06:11,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:11 INFO - 2015-11-16 04:06:11,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 328355840 04:06:11 INFO - 2015-11-16 04:06:11,589 DEBUG : BROWSER_OUTPUT: 04:06:14 INFO - 2015-11-16 04:06:14,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:15 INFO - 2015-11-16 04:06:15,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 327344128 04:06:15 INFO - 2015-11-16 04:06:15,100 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2015-11-16 04:06:16,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50505/tests/kraken/driver.html?testName=ai-astar) 04:06:17 INFO - 2015-11-16 04:06:17,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 385757184 04:06:17 INFO - 2015-11-16 04:06:17,245 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,245 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:17 INFO - 2015-11-16 04:06:17,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;111;103;125;128;127;113;120;123;123 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;175;151;190;220;156;177;172;148;193;148 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;189;187;186;182;184;187;189;182;182 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;96;106;101;82;82;82;93;97;78 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;116;161;104;104;104;146;99;98;150 04:06:17 INFO - 2015-11-16 04:06:17,246 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;141;135;142;140;135;141;135;141;131 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;146;142;149;148;146;142;141;147 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;119;122;109;119;110;119;117;119;109 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;64;66;66;68;68;68;78;68;68 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;77;78;81;83;83;82;82;80;79 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;99;102;100;101;100;101;100;101;105 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;148;145;147;153;143;145;150;160;143 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;159;183;183;182;184;163;172;177;179;180 04:06:17 INFO - 2015-11-16 04:06:17,247 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;78;79;81;84;82;84;84;84;83 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,956 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: __startTimestamp1447675577239__endTimestamp 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:17 INFO - 2015-11-16 04:06:17,248 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:118.50 Median:123.00 stddev:8.28 (6.7%) stddev-sans-first:8.44 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 103.0 125.0 128.0 127.0 113.0 120.0 123.0 123.0 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.00 Median:176.00 stddev:23.43 (13.3%) stddev-sans-first:24.84 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: Values: 175.0 151.0 190.0 220.0 156.0 177.0 172.0 148.0 193.0 148.0 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,249 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.80 Median:186.50 stddev:3.22 (1.7%) stddev-sans-first:2.92 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: Values: 180.0 189.0 187.0 186.0 182.0 184.0 187.0 189.0 182.0 182.0 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.10 Median:83.00 stddev:9.68 (11.7%) stddev-sans-first:10.01 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: Values: 84.0 96.0 106.0 101.0 82.0 82.0 82.0 93.0 97.0 78.0 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.10 Median:148.00 stddev:23.76 (16.1%) stddev-sans-first:24.91 04:06:17 INFO - 2015-11-16 04:06:17,250 DEBUG : BROWSER_OUTPUT: Values: 109.0 116.0 161.0 104.0 104.0 104.0 146.0 99.0 98.0 150.0 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.60 Median:140.50 stddev:3.81 (2.7%) stddev-sans-first:3.92 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: Values: 135.0 141.0 135.0 142.0 140.0 135.0 141.0 135.0 141.0 131.0 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:147.50 stddev:3.05 (2.1%) stddev-sans-first:3.13 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 146.0 142.0 149.0 148.0 146.0 142.0 141.0 147.0 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,251 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.20 Median:119.00 stddev:4.89 (4.1%) stddev-sans-first:5.09 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 122.0 109.0 119.0 110.0 119.0 117.0 119.0 109.0 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.00 stddev:4.20 (6.2%) stddev-sans-first:3.93 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 66.0 66.0 68.0 68.0 68.0 78.0 68.0 68.0 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.90 Median:81.50 stddev:2.92 (3.6%) stddev-sans-first:2.19 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: Values: 74.0 77.0 78.0 81.0 83.0 83.0 82.0 82.0 80.0 79.0 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.40 Median:101.50 stddev:2.50 (2.5%) stddev-sans-first:1.73 04:06:17 INFO - 2015-11-16 04:06:17,252 DEBUG : BROWSER_OUTPUT: Values: 95.0 99.0 102.0 100.0 101.0 100.0 101.0 100.0 101.0 105.0 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:147.50 stddev:5.44 (3.7%) stddev-sans-first:5.49 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: Values: 143.0 148.0 145.0 147.0 153.0 143.0 145.0 150.0 160.0 143.0 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:181.00 stddev:8.80 (4.9%) stddev-sans-first:6.79 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: Values: 159.0 183.0 183.0 182.0 184.0 163.0 172.0 177.0 179.0 180.0 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.40 Median:83.50 stddev:3.13 (3.8%) stddev-sans-first:2.32 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: Values: 75.0 78.0 79.0 81.0 84.0 82.0 84.0 84.0 84.0 83.0 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:17 INFO - 2015-11-16 04:06:17,253 DEBUG : BROWSER_OUTPUT: 04:06:18 INFO - 2015-11-16 04:06:18,014 INFO : Browser exited with error code: 0 04:06:18 INFO - 2015-11-16 04:06:18,072 INFO : Completed test kraken (00:01:01) 04:06:18 INFO - 2015-11-16 04:06:18,072 INFO : Starting test v8_7 04:06:18 INFO - 2015-11-16 04:06:18,072 DEBUG : operating with platform_type : mac_ 04:06:18 INFO - 2015-11-16 04:06:18,072 INFO : Initialising browser for v8_7 test... 04:06:18 INFO - 2015-11-16 04:06:18,087 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpbomLzc/profile http://localhost:50505/getInfo.html 04:06:20 INFO - 2015-11-16 04:06:20,561 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:20 INFO - 2015-11-16 04:06:20,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:20 INFO - 2015-11-16 04:06:20,562 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:06:20 INFO - 2015-11-16 04:06:20,562 DEBUG : BROWSER_OUTPUT: __metrics 04:06:20 INFO - 2015-11-16 04:06:20,580 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:21 INFO - 2015-11-16 04:06:21,331 INFO : Browser initialized. 04:06:21 INFO - 2015-11-16 04:06:21,332 INFO : Running cycle 1/1 for v8_7 test... 04:06:21 INFO - 2015-11-16 04:06:21,332 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/T/tmpbomLzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:33 INFO - 2015-11-16 04:06:33,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 228098048 04:06:33 INFO - 2015-11-16 04:06:33,449 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50505/tests/v8_7/run.html (next: http://localhost:50505/tests/v8_7/run.html) 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 720797696 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: |0;Richards;186.01190476190476 04:06:56 INFO - 2015-11-16 04:06:56,315 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;228.1021897810219 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |2;Encrypt;356.76061362825544 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7194.244604316546 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2197.802197802198 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |5;Earley;1058.2010582010582 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |6;Boyer;14666.666666666666 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |7;RegExp;33600 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |8;Splay;839.6305625524769 04:06:56 INFO - 2015-11-16 04:06:56,316 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6535.9477124183 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: __startTimestamp1447675616313__endTimestamp 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,317 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: Values: 186.0 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:228.10 Median:228.10 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: Values: 228.1 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:356.76 Median:356.76 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: Values: 356.8 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7194.24 Median:7194.24 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: Values: 7194.2 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,318 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2197.80 Median:2197.80 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: Values: 2197.8 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: Values: 1058.2 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14666.67 Median:14666.67 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: Values: 14666.7 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33600.00 Median:33600.00 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,319 DEBUG : BROWSER_OUTPUT: Values: 33600.0 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:839.63 Median:839.63 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: Values: 839.6 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6535.95 Median:6535.95 stddev:0.00 (0.0%) 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: Values: 6535.9 04:06:56 INFO - 2015-11-16 04:06:56,320 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:56 INFO - 2015-11-16 04:06:56,321 DEBUG : BROWSER_OUTPUT: 04:06:57 INFO - 2015-11-16 04:06:57,065 INFO : Browser exited with error code: 0 04:06:57 INFO - 2015-11-16 04:06:57,087 INFO : Completed test v8_7 (00:00:39) 04:06:57 INFO - 2015-11-16 04:06:57,303 INFO : Completed test suite (00:20:16) 04:06:57 INFO - 2015-11-16 04:06:57,303 DEBUG : Working with test: dromaeo_css 04:06:57 INFO - 2015-11-16 04:06:57,303 DEBUG : Generating results file: dromaeo_css 04:06:57 INFO - 2015-11-16 04:06:57,304 DEBUG : Working with test: kraken 04:06:57 INFO - 2015-11-16 04:06:57,304 DEBUG : Generating results file: kraken 04:06:57 INFO - 2015-11-16 04:06:57,304 INFO : javascript benchmark 04:06:57 INFO - 2015-11-16 04:06:57,305 DEBUG : Working with test: v8_7 04:06:57 INFO - 2015-11-16 04:06:57,305 DEBUG : Generating results file: v8_7 04:06:57 INFO - 2015-11-16 04:06:57,305 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:57 INFO - 2015-11-16 04:06:57,444 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 04:06:57 INFO - 2015-11-16 04:06:57,444 DEBUG : process_Request line: dromaeo_css 5921.89 graph.html#tests=[[72,1,55]] 04:06:57 INFO - 2015-11-16 04:06:57,444 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:57 INFO - 2015-11-16 04:06:57,547 DEBUG : process_Request line: kraken 1738.30 graph.html#tests=[[232,1,55]] 04:06:57 INFO - 2015-11-16 04:06:57,547 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:57 INFO - 2015-11-16 04:06:57,663 DEBUG : process_Request line: v8_7 15716.53 graph.html#tests=[[230,1,55]] 04:06:57 INFO - 2015-11-16 04:06:57,664 INFO : javascript benchmark 04:06:57 INFO - 2015-11-16 04:06:57,666 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.3845305631647, 298.9805662631929, 299.6853304030767, 308.17101995631737, 310.6536212123482, 13013.934930325335, 13437.731245375087, 14640.633984150401, 15596.766048509282, 15862.84137158628, 10285.845712314303, 10631.734206644818, 10786.137109031279, 13449.731005379886, 15741.370345186178, 3422.315536892625, 3947.1908258806875, 3984.5019372578427, 4001.399790031504, 4001.779902105383, 2981.8658160382834, 3117.0492999635103, 3803.9809800950957, 4016.7188296819236, 4120.052387950773, 4119.320312148492, 4148.543660197391, 4231.957680423203, 4234.9364759528635, 4238.894027649318, 4133.731307465006, 4145.253854306239, 4178.519470260898, 4200.936985945214, 4217.536071032184, 3506.140995456104, 3566.946495802565, 3575.606683264839, 3624.27514497099, 3629.4737263096968, 11349.0, 11568.363739994296, 11577.189596728233, 11781.58764443249, 11841.40792960357, 1616.8544830965152, 1633.2568681250123, 1674.4558018643868, 1691.0, 1691.4164613208548, 8223.095459499451, 8540.359473039547, 8624.094470080614, 8625.611847466816, 8792.8681069784, 1372.27955323455, 1390.478570536049, 1412.1103704665995, 1457.0674768148394, 1467.4350375105662, 48994.51005489935, 50568.0, 51136.0, 51359.486405135845, 51803.48196518024, 5722.885542289131, 5745.540356771448, 5756.65460072397, 5805.187273781589, 5840.328362238312, 6542.411182993458, 6643.800685979429, 6644.900326495106, 6647.368499992493, 6647.734090636417, 4578.381918441034, 4588.7935042923145, 4591.816327346935, 4604.930926036112, 4629.699069560468, 4528.47922488918, 4571.9085618287445, 4606.470255920545, 4672.859814205579, 4841.564259216617, 2606.153000274918, 2608.9347766305614, 2615.1500762251962, 2635.934101647436, 2658.9069382571515, 900.320258205051, 904.5386852705168, 910.4491782471641, 918.6233644205977, 938.3244064273712, 306.82051000165154, 349.1637528120138, 358.62702789099046, 361.41090023261916, 365.493791099324, 9411.341206115643, 9822.901770982198, 9915.900840991499, 9953.601855925683, 9994.450305233137, 349.9370113379616, 379.94870692456715, 380.708757800283, 381.3517021064202, 397.4733478141474, 4636.5131661175765, 5383.569314454834, 5425.240466334716, 5429.484199001088, 5442.455754424526, 460311.0, 461160.0, 463292.0, 464639.0, 465119.0, 56467.89426581495, 62814.0, 64482.355176448575, 64590.35409645937, 64768.35231647623, 427.77541790560207, 431.88986808363666, 434.95867892550154, 437.55806635297944, 440.4692345723396, 9513.286503512127, 9523.857142142735, 9571.1864491519, 9613.375130616487, 9723.416595004039, 29009.274768130967, 29598.704012959595, 30477.390452191277, 30944.690553095083, 30956.142631442184, 39643.405348920365, 40056.79971600123, 40631.7968410156, 40904.181916362104, 41083.7945810269, 5350.759215835219, 5364.839054828361, 5369.19462080691, 5401.756920938646, 5415.160650099241, 9362.719118426457, 9625.614975401186, 9687.176589989647, 9690.854637180308, 10247.7438064049, 7281.672324745293, 7472.589007604634, 8041.517508949481, 8403.95798021006, 8643.87034194475, 7952.284294413531, 8229.382796290183, 8340.87488687658, 8484.278836298983, 8539.957300213458, 8803.119688031145, 8872.911270887209, 8939.776505587151, 9055.230305424113, 9118.088191181094, 13364.131331463424, 13412.731745365234, 13489.460421583026, 13773.173609583457, 13911.373988170355, 13333.266670332836, 13502.122362046435, 13746.175229485863, 13843.0, 13986.650333741738], "dojo.html": [2689.44866302408, 2804.5372513535267, 2828.7736981041494, 2856.4572731181074, 2859.899903503377, 4561.315802629607, 4587.334836448713, 4621.0, 4687.086018226447, 4707.964247865469, 4529.660275479336, 4547.613452856503, 4649.488556258809, 4761.190597598408, 4920.926186107211, 4222.493300803908, 4319.76241306728, 4353.238183317922, 4363.847265345714, 4384.956150438503, 4339.067100573376, 4436.711613745097, 4439.8446054388105, 4501.819927202908, 4545.409096817409, 4245.766482843443, 4372.737635741865, 4382.824687012516, 4425.5353187915125, 4428.557144285578, 4203.4115223868685, 4320.330348795942, 4356.869293921188, 4365.563443655641, 4373.475182978032, 4337.436133302682, 4340.023494713696, 4420.602145806861, 4439.911201775979, 4449.822007119711, 4516.322551617251, 4715.669903106784, 4716.2454007359, 4730.432348118248, 4807.61539076873, 4868.9756551217015, 4952.405711314629, 4960.107180707471, 4998.850034498971, 5069.188929771219, 5012.523810238058, 5069.898602027975, 5131.486851314876, 5141.331626888518, 5173.430922598511, 4567.2920697291975, 4711.575958163748, 4712.151812673717, 4730.739809310521, 4754.334393184957, 5177.870553236199, 5194.68831870089, 5239.895202096013, 5260.631755777135, 5286.022085914118, 4976.62675299354, 4978.6017118630425, 5037.11850426174, 5072.923906141411, 5097.311862898536, 4865.56209941107, 4989.376327959005, 5107.131787596118, 5149.382074151126, 5189.766460509286, 4911.484294149134, 4978.278149668277, 5034.446210916796, 5059.316992206079, 5095.108356037753, 4934.1118598651865, 4990.351254336913, 4996.625253106032, 5021.899562008739, 5023.2214006829, 3767.2088861339425, 3864.768113913174, 3874.380099184117, 3896.9610303897166, 3932.0956180078742, 3467.115885449194, 3501.719862411052, 3539.486774417695, 3562.6793588576634, 3628.8911332660064, 4679.204535229019, 4692.0850434165695, 4721.268203428474, 4738.099761045391, 4768.856934291976, 4884.267359895973, 5024.773885175176, 5031.144705400091, 5102.948970510248, 5127.53852153308, 4679.485256621769, 4724.905501889943, 4791.209450440708, 4818.6626936114835, 4825.541573550507, 4445.711028783118, 4501.212287849678, 4533.5013148553635, 4563.634909207255, 4564.383808185852, 5248.422673505987, 5305.70818604965, 5334.59990500714, 5348.78604855817, 5382.138857782657, 5022.397312322545, 5040.521150490697, 5075.6193285502995, 5090.389153301628, 5123.718195499283, 5286.180642000496, 5333.359996800254, 5350.946490535045, 5356.919646205232, 5401.459854014567, 4778.904421911612, 4985.451600324034, 5010.974945125251, 5036.597072234139, 5118.948810511996, 4969.378827646544, 4985.675931064469, 4996.375453068366, 5005.149124648891, 5078.136716758234, 4925.310456536016, 4939.357883475269, 4979.253112033224, 4980.477049909852, 5002.174641184164, 4801.7118972861745, 4842.709437433765, 4870.464248932685, 5007.223880298559, 5014.84955451337, 4772.785224664968, 4840.2255639097575, 4892.266160075875, 4916.213405855046, 4929.16204245272, 4985.326980857682, 5005.549500544968, 5021.322121513549, 5026.824061157842, 5044.571211447068, 4808.519148085304, 4913.238448040559, 4946.8763280918265, 4952.653314267966, 4958.0], "mootools.html": [1195.3365881935522, 1511.2896938438932, 1563.1012168003397, 1600.5118438876145, 1611.6132128289207, 6286.0, 6736.259011508736, 6869.862602747949, 7001.474889383291, 7017.368436840683, 6979.267176946424, 7031.0, 7043.929560704404, 7123.216446190915, 7132.821679458016, 2028.7261219735294, 2037.5313677854103, 2042.0912693851205, 2065.483629092727, 2066.380085974209, 2054.969175462369, 2069.813716765491, 2078.833693304532, 2091.1530830013867, 2096.2139197800825, 2023.0794988280297, 2023.5952809438097, 2034.4812072921459, 2036.9287074952379, 2055.4142069510194, 2043.38698390483, 2046.6418376784004, 2059.4027731957713, 2066.71066050753, 2071.585682863426, 2025.767036790773, 2037.602667479842, 2050.4258807533765, 2052.138101997165, 2064.298138632872, 6232.1898153240245, 7004.92995070053, 7050.118735158106, 7093.077899873035, 7143.464240182007, 4059.411385349137, 4140.855070072533, 4363.36731173978, 4549.522300158469, 4567.3377360282575, 2609.712931577525, 2622.960655590168, 2706.512827691015, 2707.2284398946404, 2724.8365098093977, 689.2693744630708, 846.6909578004046, 848.2662496940164, 870.0994470722771, 879.7580665317025, 8937.240334571634, 9006.099390061006, 9174.174324310845, 9175.816483670356, 9190.035046320174, 3884.6115388460926, 3917.51134568862, 3932.7050471214775, 3955.4857868476915, 4223.852165174204, 8260.463069900437, 8264.669413223404, 8279.254867061993, 8281.668733250603, 8285.792855178548, 4536.7731613419855, 4599.33309670096, 4602.493725690171, 4602.562756538124, 4615.2384856498975, 4065.4511640928686, 4102.405151253051, 4115.403266526337, 4158.022864626811, 4161.687873409506, 3364.0580637421563, 3382.9661703383144, 3384.915377115592, 3469.8612055518, 3480.965190348115, 1090.5801266512449, 1095.8794532601407, 1102.0522350778324, 1109.8612673415823, 1116.5143162724241, 928.9303302252358, 944.7968686732386, 961.4952150121243, 998.8501724741346, 1151.240181480219, 6727.9327206728285, 6793.218779840283, 6801.387875091265, 6822.829429264308, 6823.044773731682, 410.25948163564453, 411.87437831461693, 412.81835992163354, 432.0128506363008, 433.9262325404689, 5291.153415453509, 5299.178627312773, 5342.305500284938, 5354.571634269327, 5361.0, 8043.0, 8350.874736878952, 8472.576371181416, 8590.398672092893, 8606.526641034803, 8350.33197344211, 8385.245327920395, 8388.748337549883, 8395.118512556215, 8437.198466145706, 5996.520278377807, 6377.57652092202, 6531.3142120077655, 6666.166729158856, 6762.087118239073, 6285.2457705075685, 6361.395667411589, 6592.80221593353, 6614.140161779131, 6620.900686489803, 6849.1096157499205, 6974.058502102152, 7251.41988640918, 7494.925050749423, 7546.622668866425, 7537.057867766529, 7695.345895598713, 7750.341220996053, 7779.961100194463, 7852.725154619561, 6315.96842015787, 6318.557700960889, 6405.0392441132335, 6405.3594640535575, 6415.647139407378, 6785.457163426815, 6851.45188384918, 6897.7585784497305, 6906.723731050903, 6907.13660792401, 6211.689415529115, 6329.683515824098, 6343.904841427475, 6350.364963503797, 6454.19322584677, 6229.408206220402, 6252.468540173954, 6354.618722876642, 6411.4229719325485, 6421.743130274924, 6147.84630384244, 6329.367063293634, 6340.587861788969, 6373.713182906873, 6422.3577642235405, 5828.883422331445, 5849.707514624337, 5866.2960444746905, 5902.4097590240635, 5932.79235226765, 5886.793962211302, 5964.224650795369, 6017.06735456005, 6038.033914573647, 6044.727987240497], "ext.html": [493.1640868727507, 493.4621262823522, 501.10552663495645, 510.8952664703735, 531.8165232994616, 27480.0, 28869.278268043283, 33917.99999999997, 34576.999999999935, 34756.47865282023, 36610.450843237304, 36831.81584092076, 37426.62573374266, 37450.0, 37455.0, 7354.963225183867, 7881.842363152734, 7983.880241796378, 7987.96006019972, 8055.718049868256, 7237.348638622523, 9813.411195328268, 9992.100710936014, 10001.599936002587, 10023.198144148488, 9558.330916835825, 9790.510474476283, 9791.510424478784, 9796.70609881701, 9827.213822894188, 7282.198958114604, 7459.030326057632, 7486.326230639214, 9617.23062155026, 9883.357581757164, 9801.607935682565, 9809.558569864374, 9954.0, 9961.75095622608, 9986.800263994752, 35638.8218058908, 35714.28571428557, 35853.28293434143, 35967.0, 36155.81922090399, 2632.921012369632, 2690.5651379063584, 2714.5928110783343, 2925.1224632610347, 2952.896648617288, 23760.524789504114, 23960.400989975216, 24066.15768448096, 24519.38701532458, 24894.37764055895, 2100.1074543319028, 2113.2075471698113, 2120.5758848230416, 2157.4390658428765, 2164.404788683109, 239097.0, 241838.0, 242273.0, 242790.7860460704, 245632.0, 45775.77112114418, 52387.738061310214, 52669.73665131727, 53210.0, 53350.0, 44353.77823110928, 44457.33314000293, 62298.68850655809, 62606.61753677199, 62739.0, 12989.0, 13110.803337949937, 13149.737005259842, 13177.47290108385, 13304.866951330363, 9911.504424778876, 9920.305578609428, 9922.255830812717, 9929.851052234222, 10008.199344052458, 17390.565235869206, 17508.037057961934, 17620.823791762174, 17633.55916102082, 17678.204480798395, 7225.8554828903125, 7246.891296630555, 7282.453815963824, 7293.562386256735, 7391.708570343211, 826.4586695714197, 865.2688478235881, 890.1632465482426, 929.312308891429, 1005.2711783956573, 22772.31683049511, 24306.392340191636, 24341.878290608434, 24386.146484872945, 24393.512129757306, 902.4404868981143, 908.5457271364318, 908.7591788176006, 916.4272329793879, 918.3433844801, 12624.55814046504, 12707.618771436872, 12734.61796146117, 12738.0, 12743.936280318725, 278691.0, 286433.0, 286471.0, 288209.0, 291596.0, 46916.5308346919, 47120.7643961778, 47180.5281947183, 47181.0, 48001.75999120052, 1007.5818535307765, 1089.4334945828125, 1091.5415525479318, 1193.9283642981275, 1345.9865401346253, 23777.0, 24841.627375589018, 25486.490270194863, 25831.0, 25983.740162598133, 44091.55908440874, 45536.999999998676, 45840.54159458496, 45916.311255331864, 46132.769336154444, 329952.0, 330398.0, 382890.0, 392436.0, 395134.0, 27132.186034419, 27437.17688469349, 27475.31311717223, 27489.31276718098, 27652.308692282855, 37167.62832371642, 37593.62406376011, 37913.24173516569, 38237.426438604, 38299.425508616834, 31481.21296967594, 32091.6790832098, 32250.516242255915, 32336.191595210308, 32733.836330818194, 31259.374812504077, 31489.21276968094, 31539.36921261608, 31554.842225788725, 32019.35961280808, 31542.211444713146, 32343.0, 32344.83827580847, 32410.35179296448, 33005.17487062843, 24851.00595976213, 27552.86223568869, 27704.86147569249, 27993.72006279911, 28022.579661304688, 21130.78869211288, 21173.364799056053, 21219.575608488052, 21226.575468490853, 21305.86941305857], "prototype.html": [280.8343077584225, 284.61718987961183, 287.4007693958096, 289.40671623172506, 289.70450140856343, 5534.723263836807, 5538.676793923643, 5592.804251851186, 5606.691631960241, 5613.719314034297, 5512.4211957744465, 5543.750531226095, 5545.944540554593, 5573.247611572437, 5601.719914004294, 4215.747055176684, 4236.512801027875, 4255.234057869582, 4263.232618128735, 4275.444192255002, 4203.054312779631, 4260.786960651971, 4267.359896015591, 4269.188854117708, 4280.59334363235, 3995.8801235962824, 4045.4134150548152, 4159.812808423613, 4164.167166566699, 4231.87304380869, 4184.246835569596, 4228.238916994939, 4233.25917964355, 4240.1307731914885, 4271.1671224111315, 3592.497050412944, 3613.4218525035867, 3615.439606860941, 3632.745707800455, 3647.726420518445, 5190.0, 5259.921101183485, 5274.182501712241, 5337.386200586943, 5409.648372855791, 4676.55572720591, 4757.0723708876785, 4798.04039192163, 4798.592119669832, 4816.229403295456, 5800.593958422912, 5817.069268916953, 5864.266966629171, 5901.17383566301, 5901.734421951022, 3924.2543916655745, 3927.88216353507, 3989.840406383741, 3991.1818077294083, 3994.141259629165, 5814.273215848019, 6078.9088163678025, 6152.692365381713, 6167.198264225667, 6171.691415429255, 3905.921881562353, 3906.199229158016, 3953.7034722395933, 3961.3463778476803, 3979.6816254699556, 3956.2878681837547, 3994.46074779901, 4055.9594404055583, 4118.135191609736, 4119.7940102994735, 4717.693349932243, 4738.407699037621, 4799.592034677092, 4804.9669321096135, 4810.6151507879285, 5678.545716342683, 5802.245708057925, 5803.100519419497, 5855.3266374367495, 5855.824325270249, 1434.0606902478894, 1445.284584130862, 1445.869871711551, 1446.768517037269, 1461.101422625078, 932.5383934952107, 938.5307346326837, 943.6225509796136, 944.1078181118914, 960.7454024683465, 5600.971995140079, 5673.546116310686, 5676.035074037423, 5681.801136960186, 5692.089265717465, 5993.61041532299, 5995.52035837132, 6106.938930610726, 6108.267007958984, 6116.816495505142, 5629.802956896489, 5635.182898479779, 5673.631213971079, 5674.546036317085, 5687.914681279784, 3172.809631422122, 3259.543663887058, 3263.118957881406, 3266.5426840242385, 3318.8672453101603, 6304.968475157595, 6340.080688300171, 6353.205849268841, 6354.777582784581, 6378.553501254868, 6147.293061298008, 6223.844403889939, 6234.220722409699, 6246.656433896179, 6270.122182894398, 6084.117802918552, 6313.936860631335, 6355.586886852339, 6362.0774987627465, 6386.0, 6062.120992455981, 6072.514198864169, 6082.6046306991675, 6093.451589356979, 6106.816795496142, 5878.882422351444, 5938.792142275172, 5949.702514874152, 5964.761409543569, 5967.940320596912, 6112.083187521907, 6346.904796427965, 6349.0476428536085, 6361.363863613602, 6372.490200783834, 3968.087339911894, 4024.2353952748886, 4032.91934161321, 4046.838126474908, 4070.9796451017555, 6032.155498230163, 6088.056351265561, 6094.481969032682, 6097.0, 6103.08453731926, 5902.704864756831, 5905.320888097752, 5917.319508256605, 5923.970380148244, 5940.495057920125, 5772.855678608068, 5821.505172060253, 5884.735186916685, 5893.941060589511, 5972.70136493165, 5689.516391106802, 5810.970945145247, 5837.474627283395, 5844.12338149281, 5851.0, 5843.970780146072, 5854.619449735754, 5855.121731740273, 5946.524278057658, 5963.9105413417965, 5673.631213971244, 5729.255196824386, 5765.106408506688, 5829.737661805314, 5838.708064596668], "yui.html": [667.5494041521971, 675.3010633993817, 678.9388954994052, 688.8553403785205, 695.8956156576514, 12318.81521777173, 12381.442835072421, 12584.244945303266, 12591.811122833165, 12611.43248553815, 11455.198136130473, 11513.251638643482, 11591.6522504325, 11596.710082247948, 11605.3036817791, 615.2985596420085, 636.7962252079336, 737.3069314844056, 767.4014268870291, 797.3182928596054, 778.8014056415634, 784.4704824243641, 790.7983464216617, 791.4143533785016, 800.1878093734864, 818.664347617477, 819.2994989284166, 827.4208054361941, 829.1045670675655, 833.4499230507867, 646.5474168082337, 653.3564439027554, 654.8199245207559, 809.9392545559107, 830.2486249943811, 620.0791824141147, 620.2494981072907, 621.546271222006, 622.7851391270004, 623.0840664223584, 10495.42275174865, 10497.0, 10541.578336866516, 10557.313774604627, 10643.0421262086, 10125.696229113139, 10192.184625229964, 10447.582096716122, 11041.889581104166, 11107.222494425394, 8385.0, 8447.408681392244, 8456.365772567082, 8493.320534357237, 8898.42160259581, 2962.9407411851644, 3034.332446861687, 3076.2463196516997, 3089.5056790913345, 3132.15431833406, 43237.78381108074, 44424.11151776947, 44520.3321950171, 44621.55378446206, 44637.77681111606, 7964.203579642105, 8125.95937020323, 8132.146124656944, 8394.328453723687, 8661.090585488559, 17140.0, 17141.657166856843, 17146.05696686694, 17203.13984300805, 17319.826801731822, 6290.716917738713, 6355.745770169141, 6474.838129046811, 6540.117084193668, 6623.701933413008, 3437.2781715839956, 3534.3814832404228, 3569.0720412692885, 3614.042278796121, 3720.795356255432, 2634.3414146463383, 2668.5730283154603, 2669.4394177223003, 2670.452557225764, 2677.8259413138085, 391.6925213707283, 396.20363070229047, 483.91773398521633, 501.15305134322875, 505.48440590597386, 478.7917255993584, 521.8304051183304, 531.3066448285025, 538.8087229033715, 547.479894100606, 7055.259197784261, 7265.452456645921, 7321.377682896907, 7460.552366857897, 7567.9243207568325, 365.2366553902357, 434.92823684092406, 468.94841567427557, 490.6859609849699, 553.8864532770772, 3250.431174544445, 3431.4166591679473, 3512.9121771955392, 3573.5711714594413, 3651.087228192952, 48241.0, 48428.75785621049, 48653.270200947016, 48671.0, 48753.268700969515, 43115.56884431178, 45687.771561141984, 45919.0, 45932.311015334795, 46106.0, 39042.0, 39864.800675997016, 41362.379564307164, 41938.0, 42040.78979605083, 7117.252688467636, 7200.279972002758, 7500.012402454763, 7540.9622951884885, 7618.847623047619, 29407.0, 29854.552181717725, 31329.06012819619, 31503.21241968969, 31505.8424707875, 38183.61816381912, 38505.422418664304, 38773.80613096916, 41070.66081409517, 41178.79410602928, 6595.307492713196, 6804.813501772765, 6958.304169583002, 6959.478039147186, 7139.428845692229, 9834.75413114678, 9904.108630223314, 10023.799524009624, 10132.493375331056, 10464.0, 9157.267418606361, 9357.672481463389, 9436.669716559887, 9552.522373881138, 10098.697039088838, 9825.656102036395, 9898.554565044735, 9909.504524773589, 10109.241806864367, 10665.0, 9677.70966870995, 9689.22486201088, 9795.706128816148, 9812.656557020755, 9912.752181195528, 8226.753197403848, 8241.917580824114, 8801.38390312672, 8885.0, 8892.199702026848, 7619.9238007619215, 8145.0, 8151.266386025286, 8277.751667449986, 8506.574671266535]}, "summary": {"lowerIsBetter": false, "suite": 5921.8905757200855, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5921.051068189989, "unit": "ms", "value": 5921.051068189989}, "dojo.html": {"lowerIsBetter": false, "filtered": 4683.696600327527, "unit": "ms", "value": 4683.696600327527}, "mootools.html": {"lowerIsBetter": false, "filtered": 3971.253399621673, "unit": "ms", "value": 3971.253399621673}, "ext.html": {"lowerIsBetter": false, "filtered": 16509.335818523345, "unit": "ms", "value": 16509.335818523345}, "prototype.html": {"lowerIsBetter": false, "filtered": 4387.573563829762, "unit": "ms", "value": 4387.573563829762}, "yui.html": {"lowerIsBetter": false, "filtered": 5405.701618555204, "unit": "ms", "value": 5405.701618555204}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0091"}, "testrun": {"date": 1447674400, "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": "20151116025234", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 189.0, 187.0, 186.0, 182.0, 184.0, 187.0, 189.0, 182.0, 182.0], "ai-astar": [112.0, 111.0, 103.0, 125.0, 128.0, 127.0, 113.0, 120.0, 123.0, 123.0], "imaging-gaussian-blur": [135.0, 141.0, 135.0, 142.0, 140.0, 135.0, 141.0, 135.0, 141.0, 131.0], "audio-beat-detection": [175.0, 151.0, 190.0, 220.0, 156.0, 177.0, 172.0, 148.0, 193.0, 148.0], "json-stringify-tinderbox": [74.0, 77.0, 78.0, 81.0, 83.0, 83.0, 82.0, 82.0, 80.0, 79.0], "stanford-crypto-pbkdf2": [159.0, 183.0, 183.0, 182.0, 184.0, 163.0, 172.0, 177.0, 179.0, 180.0], "json-parse-financial": [62.0, 64.0, 66.0, 66.0, 68.0, 68.0, 68.0, 78.0, 68.0, 68.0], "stanford-crypto-sha256-iterative": [75.0, 78.0, 79.0, 81.0, 84.0, 82.0, 84.0, 84.0, 84.0, 83.0], "audio-fft": [84.0, 96.0, 106.0, 101.0, 82.0, 82.0, 82.0, 93.0, 97.0, 78.0], "imaging-darkroom": [148.0, 149.0, 146.0, 142.0, 149.0, 148.0, 146.0, 142.0, 141.0, 147.0], "stanford-crypto-ccm": [143.0, 148.0, 145.0, 147.0, 153.0, 143.0, 145.0, 150.0, 160.0, 143.0], "audio-oscillator": [109.0, 116.0, 161.0, 104.0, 104.0, 104.0, 146.0, 99.0, 98.0, 150.0], "stanford-crypto-aes": [95.0, 99.0, 102.0, 100.0, 101.0, 100.0, 101.0, 100.0, 101.0, 105.0], "imaging-desaturate": [119.0, 119.0, 122.0, 109.0, 119.0, 110.0, 119.0, 117.0, 119.0, 109.0]}, "summary": {"lowerIsBetter": true, "suite": 1738.3000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 90.1, "unit": "ms", "value": 90.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 176.2, "unit": "ms", "value": 176.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 173.0, "unit": "ms", "value": 173.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 147.7, "unit": "ms", "value": 147.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 67.6, "unit": "ms", "value": 67.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 119.1, "unit": "ms", "value": 119.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 118.5, "unit": "ms", "value": 118.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 184.8, "unit": "ms", "value": 184.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 81.4, "unit": "ms", "value": 81.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 79.9, "unit": "ms", "value": 79.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 137.6, "unit": "ms", "value": 137.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 100.4, "unit": "ms", "value": 100.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 116.2, "unit": "ms", "value": 116.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0091"}, "testrun": {"date": 1447674400, "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": "20151116025234", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [228.1021897810219], "Encrypt": [356.76061362825544], "NavierStokes": [6535.9477124183], "Decrypt": [7194.244604316546], "Splay": [839.6305625524769], "Richards": [186.01190476190476], "RegExp": [33600.0], "Earley": [1058.2010582010582], "Boyer": [14666.666666666666], "RayTrace": [2197.802197802198]}, "summary": {"lowerIsBetter": false, "suite": 15716.527627794838, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 289.86131199999994, "unit": "score", "value": 289.86131199999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 746.1053429999998, "unit": "score", "value": 746.1053429999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 227.05199999999994, "unit": "score", "value": 227.05199999999994}, "Decrypt": {"lowerIsBetter": false, "filtered": 36.99915899999997, "unit": "score", "value": 36.99915899999997}, "Splay": {"lowerIsBetter": false, "filtered": 97.055781, "unit": "score", "value": 97.055781}, "RegExp": {"lowerIsBetter": false, "filtered": 27.112648809523805, "unit": "score", "value": 27.112648809523805}, "Richards": {"lowerIsBetter": false, "filtered": 189.78355199999996, "unit": "score", "value": 189.78355199999996}, "Earley": {"lowerIsBetter": false, "filtered": 629.8075349999997, "unit": "score", "value": 629.8075349999997}, "Boyer": {"lowerIsBetter": false, "filtered": 45.440659090909094, "unit": "score", "value": 45.440659090909094}, "RayTrace": {"lowerIsBetter": false, "filtered": 336.69499499999984, "unit": "score", "value": 336.69499499999984}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0091"}, "testrun": {"date": 1447674400, "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": "20151116025234", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 04:06:57 INFO - RETURN: dromaeo_css: 5921.89 04:06:57 INFO - RETURN: kraken: 1738.30 04:06:57 INFO - RETURN: v8_7: 15716.53 04:06:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15716.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1738.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5921.89"}}} 04:06:57 INFO - Return code: 0 04:06:57 INFO - # TBPL SUCCESS # 04:06:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:06:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:06:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:06:57 INFO - 2015-11-16 04:06:57.802 screenresolution[2821:24931] starting screenresolution argv=screenresolution get 04:06:57 INFO - 2015-11-16 04:06:57.805 screenresolution[2821:24931] Display 0: 1600x1200x32@60 04:06:57 INFO - 2015-11-16 04:06:57.811 screenresolution[2822:24934] starting screenresolution argv=screenresolution list 04:06:57 INFO - Available Modes on Display 0 04:06:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:06:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:06:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:06:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:06:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:06:58 INFO - Intel HD Graphics 3000: 04:06:58 INFO - Chipset Model: Intel HD Graphics 3000 04:06:58 INFO - Type: GPU 04:06:58 INFO - Bus: Built-In 04:06:58 INFO - VRAM (Total): 512 MB 04:06:58 INFO - VRAM (Dynamic, Max): 10 04:06:58 INFO - Vendor: Intel (0x8086) 04:06:58 INFO - Device ID: 0x0116 04:06:58 INFO - Revision ID: 0x0009 04:06:58 INFO - Displays: 04:06:58 INFO - Display: 04:06:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:06:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:06:58 INFO - Display Serial Number: 1600x1200 60 04:06:58 INFO - Main Display: Yes 04:06:58 INFO - Mirror: Off 04:06:58 INFO - Online: Yes 04:06:58 INFO - Rotation: Supported 04:06:58 INFO - Return code: 0 04:06:58 INFO - Running post-action listener: _resource_record_post_action 04:06:58 INFO - Running post-run listener: _resource_record_post_run 04:06:59 INFO - Total resource usage - Wall time: 1259s; CPU: 30.0%; Read bytes: 208896; Write bytes: 688806912; Read time: 109; Write time: 85250 04:06:59 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 334397952; Write bytes: 336564224; Read time: 35008; Write time: 30526 04:06:59 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 208896; Write bytes: 341879808; Read time: 109; Write time: 51021 04:06:59 INFO - Running post-run listener: _upload_blobber_files 04:06:59 INFO - Blob upload gear active. 04:06:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:06:59 INFO - Copying logs to upload dir... 04:06:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1332.873747 ========= master_lag: 64.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 17 secs) (at 2015-11-16 04:08:03.355558) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 04:08:03.361596) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010346 build_url: 'https://queue.taskcluster.net/v1/task/84cS3h34QLKhJNe9MTCCTA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.59 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 04:08:03.957537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 04:08:03.957882) ========= 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.wllGRcsn6B/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.8r1YdwNoDE/Listeners TMPDIR=/var/folders/y5/bmhtb1k154z3c1gnjqtfq5t000000w/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.005293 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 04:08:04.022184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 04:08:04.022513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 04:08:04.033588) ========= ========= Total master_lag: 64.94 =========