builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0041 starttime: 1447861472.32 results: success (0) buildid: 20151118055124 builduid: ce34fd181fd54a40b2bbe96e3cc9f471 revision: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.318619) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.319203) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.319692) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.006268 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.343511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.343810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.359791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.360105) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.005296 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.408747) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.409063) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.409431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.409712) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-18 07:44:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.66M=0.001s 2015-11-18 07:44:32 (8.66 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.617411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.617802) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.020486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:32.668114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 07:44:32.668469) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --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 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-18 07:44:32,744 truncating revision to first 12 chars 2015-11-18 07:44:32,745 Setting DEBUG logging. 2015-11-18 07:44:32,745 attempt 1/10 2015-11-18 07:44:32,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d6155d7e6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:44:33,723 unpacking tar archive at: mozilla-central-1d6155d7e6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 07:44:33.913154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:33.913485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:33.927445) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:33.927892) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:44:33.928452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2015-11-18 07:44:33.928910) ========= /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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:44:34 INFO - MultiFileLogger online at 20151118 07:44:34 in /builds/slave/test 07:44:34 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 07:44:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:34 INFO - {'append_to_log': False, 07:44:34 INFO - 'base_work_dir': '/builds/slave/test', 07:44:34 INFO - 'blob_upload_branch': 'Firefox', 07:44:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:34 INFO - 'branch': 'Firefox', 07:44:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:34 INFO - 'config_files': ('talos/mac_config.py',), 07:44:34 INFO - 'default_actions': ('clobber', 07:44:34 INFO - 'read-buildbot-config', 07:44:34 INFO - 'download-and-extract', 07:44:34 INFO - 'populate-webroot', 07:44:34 INFO - 'create-virtualenv', 07:44:34 INFO - 'install', 07:44:34 INFO - 'run-tests'), 07:44:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:34 INFO - 'download_minidump_stackwalk': True, 07:44:34 INFO - 'download_symbols': 'ondemand', 07:44:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:34 INFO - 'installer_path': 'installer.exe', 07:44:34 INFO - 'log_level': 'info', 07:44:34 INFO - 'log_name': 'talos', 07:44:34 INFO - 'log_to_console': True, 07:44:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:44:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:44:34 INFO - 'opt_config_files': (), 07:44:34 INFO - 'pip_index': False, 07:44:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:34 INFO - 'cmd': ('bash', 07:44:34 INFO - '-c', 07:44:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:34 INFO - 'enabled': True, 07:44:34 INFO - 'halt_on_failure': False, 07:44:34 INFO - 'name': 'check_screen_resolution'},), 07:44:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:44:34 INFO - 'cmd': ('bash', 07:44:34 INFO - '-c', 07:44:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:44:34 INFO - 'enabled': True, 07:44:34 INFO - 'halt_on_failure': False, 07:44:34 INFO - 'name': 'check_screen_resolution'},), 07:44:34 INFO - 'run_cmd_checks_enabled': True, 07:44:34 INFO - 'sps_profile': False, 07:44:34 INFO - 'sps_profile_interval': 0, 07:44:34 INFO - 'suite': 'dromaeojs', 07:44:34 INFO - 'system_bits': '64', 07:44:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:34 INFO - 'title': 't-yosemite-r5-0041', 07:44:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:34 INFO - 'use_talos_json': True, 07:44:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:34 INFO - 'work_dir': 'build'} 07:44:34 INFO - ##### 07:44:34 INFO - ##### Running clobber step. 07:44:34 INFO - ##### 07:44:34 INFO - Running pre-action listener: _resource_record_pre_action 07:44:34 INFO - Running main action method: clobber 07:44:34 INFO - rmtree: /builds/slave/test/build 07:44:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:35 INFO - Running post-action listener: _resource_record_post_action 07:44:35 INFO - ##### 07:44:35 INFO - ##### Running read-buildbot-config step. 07:44:35 INFO - ##### 07:44:35 INFO - Running pre-action listener: _resource_record_pre_action 07:44:35 INFO - Running main action method: read_buildbot_config 07:44:35 INFO - Using buildbot properties: 07:44:35 INFO - { 07:44:35 INFO - "properties": { 07:44:35 INFO - "buildnumber": 487, 07:44:35 INFO - "product": "firefox", 07:44:35 INFO - "script_repo_revision": "production", 07:44:35 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 07:44:35 INFO - "repository": "", 07:44:35 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 07:44:35 INFO - "buildid": "20151118055124", 07:44:35 INFO - "slavename": "t-yosemite-r5-0041", 07:44:35 INFO - "pgo_build": "False", 07:44:35 INFO - "basedir": "/builds/slave/test", 07:44:35 INFO - "project": "", 07:44:35 INFO - "platform": "yosemite", 07:44:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:44:35 INFO - "slavebuilddir": "test", 07:44:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:44:35 INFO - "branch": "mozilla-central", 07:44:35 INFO - "repo_path": "mozilla-central", 07:44:35 INFO - "stage_platform": "macosx64", 07:44:35 INFO - "builduid": "ce34fd181fd54a40b2bbe96e3cc9f471", 07:44:35 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:44:35 INFO - }, 07:44:35 INFO - "sourcestamp": { 07:44:35 INFO - "repository": "", 07:44:35 INFO - "hasPatch": false, 07:44:35 INFO - "project": "", 07:44:35 INFO - "branch": "mozilla-central-macosx64-talos", 07:44:35 INFO - "changes": [ 07:44:35 INFO - { 07:44:35 INFO - "category": null, 07:44:35 INFO - "files": [ 07:44:35 INFO - { 07:44:35 INFO - "url": null, 07:44:35 INFO - "name": "https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:44:35 INFO - } 07:44:35 INFO - ], 07:44:35 INFO - "repository": "", 07:44:35 INFO - "rev": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d", 07:44:35 INFO - "who": "cbook@mozilla.com", 07:44:35 INFO - "when": 1447861342, 07:44:35 INFO - "number": 6677342, 07:44:35 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 07:44:35 INFO - "project": "", 07:44:35 INFO - "at": "Wed 18 Nov 2015 07:42:22", 07:44:35 INFO - "branch": "mozilla-central-macosx64-talos", 07:44:35 INFO - "revlink": "", 07:44:35 INFO - "properties": [ 07:44:35 INFO - [ 07:44:35 INFO - "buildid", 07:44:35 INFO - "20151118055124", 07:44:35 INFO - "Change" 07:44:35 INFO - ], 07:44:35 INFO - [ 07:44:35 INFO - "builduid", 07:44:35 INFO - "ce34fd181fd54a40b2bbe96e3cc9f471", 07:44:35 INFO - "Change" 07:44:35 INFO - ], 07:44:35 INFO - [ 07:44:35 INFO - "pgo_build", 07:44:35 INFO - "False", 07:44:35 INFO - "Change" 07:44:35 INFO - ] 07:44:35 INFO - ], 07:44:35 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:44:35 INFO - } 07:44:35 INFO - ], 07:44:35 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:44:35 INFO - } 07:44:35 INFO - } 07:44:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:44:35 INFO - Running post-action listener: _resource_record_post_action 07:44:35 INFO - ##### 07:44:35 INFO - ##### Running download-and-extract step. 07:44:35 INFO - ##### 07:44:35 INFO - Running pre-action listener: _resource_record_pre_action 07:44:35 INFO - Running main action method: download_and_extract 07:44:35 INFO - mkdir: /builds/slave/test/build/tests 07:44: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')]} 07:44:35 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json 07:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json 07:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:44:52 INFO - Downloaded 1149 bytes. 07:44:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:44:53 INFO - Using the following test package requirements: 07:44:53 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:44:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:44:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'jsshell-mac.zip'], 07:44:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:44:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:44:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:44:53 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:44:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:44:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:44:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:44:53 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:44:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:44: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')]} 07:44:53 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:44:54 INFO - Downloaded 17463548 bytes. 07:44:54 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 07:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:44:58 INFO - Return code: 0 07:44:58 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 07:44: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')]} 07:44:58 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:45:03 INFO - Downloaded 17463548 bytes. 07:45:03 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 07:45:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:45:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:45:09 INFO - Return code: 0 07:45:09 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')]} 07:45:09 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:45:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:45:10 INFO - Downloaded 11130997 bytes. 07:45:10 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 07:45:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:45:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:45:10 INFO - Return code: 0 07:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:10 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:45:15 INFO - Downloaded 108847488 bytes. 07:45:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:45:15 INFO - mkdir: /builds/slave/test/properties 07:45:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:45:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:45:15 INFO - Contents: 07:45:15 INFO - build_url:https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:45:15 INFO - Running post-action listener: _resource_record_post_action 07:45:15 INFO - Running post-action listener: set_extra_try_arguments 07:45:15 INFO - ##### 07:45:15 INFO - ##### Running populate-webroot step. 07:45:15 INFO - ##### 07:45:15 INFO - Running pre-action listener: _resource_record_pre_action 07:45:15 INFO - Running main action method: populate_webroot 07:45:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:45:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:45:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:45:15 INFO - '../fennec_ids.txt'], 07:45:15 INFO - 'tests': ['tcheck2']}, 07:45:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:45:15 INFO - '--tppagecycles', 07:45:15 INFO - '7'], 07:45:15 INFO - 'tests': ['tsvgm']}}, 07:45:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:45:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:45:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:45:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:45:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'tests': ['damp', 'tps']}, 07:45:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['damp', 'tps']}, 07:45:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:45:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:45:15 INFO - 'other': {'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'other_l64': {'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'other_nol64': {'tests': ['a11yr', 07:45:15 INFO - 'ts_paint', 07:45:15 INFO - 'tpaint', 07:45:15 INFO - 'sessionrestore', 07:45:15 INFO - 'sessionrestore_no_auto_restore']}, 07:45:15 INFO - 'svgr': {'tests': ['tsvgx', 07:45:15 INFO - 'tsvgr_opacity', 07:45:15 INFO - 'tart', 07:45:15 INFO - 'tscrollx', 07:45:15 INFO - 'cart']}, 07:45:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['tsvgx', 07:45:15 INFO - 'tsvgr_opacity', 07:45:15 INFO - 'tart', 07:45:15 INFO - 'tscrollx', 07:45:15 INFO - 'cart']}, 07:45:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'tests': ['tp5o']}, 07:45:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'talos_options': ['--e10s'], 07:45:15 INFO - 'tests': ['tp5o']}, 07:45:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'talos_options': ['--xperf_path', 07:45:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:15 INFO - 'tests': ['tp5n']}, 07:45:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:15 INFO - 'talos_options': ['--e10s', 07:45:15 INFO - '--xperf_path', 07:45:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:15 INFO - 'tests': ['tp5n']}}, 07:45:15 INFO - 'talos.zip': {'path': '', 07:45:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:45:15 INFO - Running post-action listener: _resource_record_post_action 07:45:15 INFO - ##### 07:45:15 INFO - ##### Running create-virtualenv step. 07:45:15 INFO - ##### 07:45:15 INFO - Running pre-action listener: _resource_record_pre_action 07:45:15 INFO - Running main action method: create_virtualenv 07:45:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:45:15 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 07:45:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:45:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:45:15 INFO - Using real prefix '/tools/python27' 07:45:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:45:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:45:19 INFO - Installing pip.................done. 07:45:19 INFO - Return code: 0 07:45:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:19 INFO - 'HOME': '/Users/cltbld', 07:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:19 INFO - 'LOGNAME': 'cltbld', 07:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:19 INFO - 'MOZ_NO_REMOTE': '1', 07:45:19 INFO - 'NO_EM_RESTART': '1', 07:45:19 INFO - 'PAGER': '/bin/cat', 07:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:19 INFO - 'PWD': '/builds/slave/test', 07:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:19 INFO - 'SHELL': '/bin/bash', 07:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:19 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:19 INFO - 'USER': 'cltbld', 07:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:19 INFO - 'XPC_FLAGS': '0x0', 07:45:19 INFO - 'XPC_SERVICE_NAME': '0', 07:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:19 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 07:45:19 INFO - Cleaning up... 07:45:19 INFO - Return code: 0 07:45:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:19 INFO - 'HOME': '/Users/cltbld', 07:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:19 INFO - 'LOGNAME': 'cltbld', 07:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:19 INFO - 'MOZ_NO_REMOTE': '1', 07:45:19 INFO - 'NO_EM_RESTART': '1', 07:45:19 INFO - 'PAGER': '/bin/cat', 07:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:19 INFO - 'PWD': '/builds/slave/test', 07:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:19 INFO - 'SHELL': '/bin/bash', 07:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:19 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:19 INFO - 'USER': 'cltbld', 07:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:19 INFO - 'XPC_FLAGS': '0x0', 07:45:19 INFO - 'XPC_SERVICE_NAME': '0', 07:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:20 INFO - Downloading/unpacking psutil>=0.7.1 07:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:22 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:45:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:45:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:22 INFO - Installing collected packages: psutil 07:45:22 INFO - Running setup.py install for psutil 07:45:22 INFO - building 'psutil._psutil_osx' extension 07:45:22 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 07:45:23 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 07:45:23 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 07:45:23 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 07:45:23 INFO - building 'psutil._psutil_posix' extension 07:45:23 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 07:45:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:45:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:45:23 INFO - ^ 07:45:23 INFO - 1 warning generated. 07:45:23 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 07:45:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:23 INFO - Successfully installed psutil 07:45:23 INFO - Cleaning up... 07:45:23 INFO - Return code: 0 07:45:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:23 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 07:45:23 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 07:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:23 INFO - 'HOME': '/Users/cltbld', 07:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:23 INFO - 'LOGNAME': 'cltbld', 07:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:23 INFO - 'MOZ_NO_REMOTE': '1', 07:45:23 INFO - 'NO_EM_RESTART': '1', 07:45:23 INFO - 'PAGER': '/bin/cat', 07:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:23 INFO - 'PWD': '/builds/slave/test', 07:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:23 INFO - 'SHELL': '/bin/bash', 07:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:23 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:23 INFO - 'USER': 'cltbld', 07:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:23 INFO - 'XPC_FLAGS': '0x0', 07:45:23 INFO - 'XPC_SERVICE_NAME': '0', 07:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:45:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:45:27 INFO - Installing collected packages: mozsystemmonitor 07:45:27 INFO - Running setup.py install for mozsystemmonitor 07:45:27 INFO - Successfully installed mozsystemmonitor 07:45:27 INFO - Cleaning up... 07:45:27 INFO - Return code: 0 07:45:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:45:27 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')]} 07:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:27 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')]} 07:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:27 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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:27 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 07:45:27 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 07:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:27 INFO - 'HOME': '/Users/cltbld', 07:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:27 INFO - 'LOGNAME': 'cltbld', 07:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:27 INFO - 'MOZ_NO_REMOTE': '1', 07:45:27 INFO - 'NO_EM_RESTART': '1', 07:45:27 INFO - 'PAGER': '/bin/cat', 07:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:27 INFO - 'PWD': '/builds/slave/test', 07:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:27 INFO - 'SHELL': '/bin/bash', 07:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:27 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:27 INFO - 'USER': 'cltbld', 07:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:27 INFO - 'XPC_FLAGS': '0x0', 07:45:27 INFO - 'XPC_SERVICE_NAME': '0', 07:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:45:27 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 07:45:27 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 07:45:27 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 07:45:27 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 07:45:27 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 07:45:27 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 07:45:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:30 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 07:45:31 INFO - Downloading docopt-0.6.1.tar.gz 07:45:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:31 INFO - Running setup.py install for blobuploader 07:45:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:31 INFO - Running setup.py install for requests 07:45:31 INFO - Running setup.py install for docopt 07:45:32 INFO - Successfully installed blobuploader requests docopt 07:45:32 INFO - Cleaning up... 07:45:32 INFO - Return code: 0 07:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:32 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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:32 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 07:45:32 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 07:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:32 INFO - 'HOME': '/Users/cltbld', 07:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:32 INFO - 'LOGNAME': 'cltbld', 07:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:32 INFO - 'MOZ_NO_REMOTE': '1', 07:45:32 INFO - 'NO_EM_RESTART': '1', 07:45:32 INFO - 'PAGER': '/bin/cat', 07:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:32 INFO - 'PWD': '/builds/slave/test', 07:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:32 INFO - 'SHELL': '/bin/bash', 07:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:32 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:32 INFO - 'USER': 'cltbld', 07:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:32 INFO - 'XPC_FLAGS': '0x0', 07:45:32 INFO - 'XPC_SERVICE_NAME': '0', 07:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-zaR_Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-EnpgpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-EfEoLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-TFz_SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-EYQyrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-WCxFE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-vxPSEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-dLuFKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-cS9ClC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-cAsjmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-2JuDEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-xMP_YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-gPmqFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-YCbefJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:34 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-cCT2hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:34 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-kw8Uyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:34 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-m4lcys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:34 INFO - Running setup.py install for manifestparser 07:45:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:34 INFO - Running setup.py install for mozcrash 07:45:34 INFO - Running setup.py install for mozdebug 07:45:34 INFO - Running setup.py install for mozdevice 07:45:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Running setup.py install for mozfile 07:45:35 INFO - Running setup.py install for mozhttpd 07:45:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Running setup.py install for mozinfo 07:45:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Running setup.py install for mozInstall 07:45:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:35 INFO - Running setup.py install for mozleak 07:45:35 INFO - Running setup.py install for mozlog 07:45:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Running setup.py install for moznetwork 07:45:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Running setup.py install for mozprocess 07:45:36 INFO - Running setup.py install for mozprofile 07:45:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Running setup.py install for mozrunner 07:45:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:36 INFO - Running setup.py install for mozscreenshot 07:45:36 INFO - Running setup.py install for moztest 07:45:37 INFO - Running setup.py install for mozversion 07:45:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:37 INFO - Cleaning up... 07:45:37 INFO - Return code: 0 07:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:37 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')]} 07:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:37 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')]} 07:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:37 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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:37 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 07:45:37 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 07:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:37 INFO - 'HOME': '/Users/cltbld', 07:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:37 INFO - 'LOGNAME': 'cltbld', 07:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:37 INFO - 'MOZ_NO_REMOTE': '1', 07:45:37 INFO - 'NO_EM_RESTART': '1', 07:45:37 INFO - 'PAGER': '/bin/cat', 07:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:37 INFO - 'PWD': '/builds/slave/test', 07:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:37 INFO - 'SHELL': '/bin/bash', 07:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:37 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:37 INFO - 'USER': 'cltbld', 07:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:37 INFO - 'XPC_FLAGS': '0x0', 07:45:37 INFO - 'XPC_SERVICE_NAME': '0', 07:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-tAPAcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:37 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)) 07:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-6XC10L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:37 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)) 07:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-ra1ljx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:37 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)) 07:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-R6daHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-97Zk01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-YntNUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-lFL9bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-GwIayN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-HcPvsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-_4mpaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-30BJXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-DuXO1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:38 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)) 07:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-8PEaZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:39 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)) 07:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:39 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-4n58IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:39 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)) 07:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:39 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-aoOJsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:39 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)) 07:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:39 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-MtrHs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:39 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)) 07:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:39 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-QSnTrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:39 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)) 07:45:39 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)) 07:45:39 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)) 07:45:39 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)) 07:45:39 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)) 07:45:39 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)) 07:45:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07: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 07: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 07: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 07: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 07: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 07: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 07:45:41 INFO - Downloading blessings-1.5.1.tar.gz 07:45:41 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 07:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:41 INFO - Installing collected packages: blessings 07:45:41 INFO - Running setup.py install for blessings 07:45:42 INFO - Successfully installed blessings 07:45:42 INFO - Cleaning up... 07:45:42 INFO - Return code: 0 07:45:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:42 INFO - Reading from file tmpfile_stdout 07:45:42 INFO - Current package versions: 07:45:42 INFO - blessings == 1.5.1 07:45:42 INFO - blobuploader == 1.2.4 07:45:42 INFO - docopt == 0.6.1 07:45:42 INFO - manifestparser == 1.1 07:45:42 INFO - mozInstall == 1.12 07:45:42 INFO - mozcrash == 0.16 07:45:42 INFO - mozdebug == 0.1 07:45:42 INFO - mozdevice == 0.47 07:45:42 INFO - mozfile == 1.2 07:45:42 INFO - mozhttpd == 0.7 07:45:42 INFO - mozinfo == 0.9 07:45:42 INFO - mozleak == 0.1 07:45:42 INFO - mozlog == 3.0 07:45:42 INFO - moznetwork == 0.27 07:45:42 INFO - mozprocess == 0.22 07:45:42 INFO - mozprofile == 0.27 07:45:42 INFO - mozrunner == 6.11 07:45:42 INFO - mozscreenshot == 0.1 07:45:42 INFO - mozsystemmonitor == 0.0 07:45:42 INFO - moztest == 0.7 07:45:42 INFO - mozversion == 1.4 07:45:42 INFO - psutil == 3.1.1 07:45:42 INFO - requests == 1.2.3 07:45:42 INFO - wsgiref == 0.1.2 07:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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', '-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 0x10f68a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, '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.6CFSzfEGKx/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.0wCpbwePlL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 07:45:42 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 07:45:42 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 07:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:45:42 INFO - 'HOME': '/Users/cltbld', 07:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:45:42 INFO - 'LOGNAME': 'cltbld', 07:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:42 INFO - 'MOZ_NO_REMOTE': '1', 07:45:42 INFO - 'NO_EM_RESTART': '1', 07:45:42 INFO - 'PAGER': '/bin/cat', 07:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:42 INFO - 'PWD': '/builds/slave/test', 07:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:45:42 INFO - 'SHELL': '/bin/bash', 07:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:45:42 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:45:42 INFO - 'USER': 'cltbld', 07:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:42 INFO - 'XPC_FLAGS': '0x0', 07:45:42 INFO - 'XPC_SERVICE_NAME': '0', 07:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 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)) 07:45:42 INFO - Cleaning up... 07:45:42 INFO - Return code: 0 07:45:42 INFO - Running post-action listener: _resource_record_post_action 07:45:42 INFO - Running post-action listener: _start_resource_monitoring 07:45:42 INFO - Starting resource monitoring. 07:45:42 INFO - ##### 07:45:42 INFO - ##### Running install step. 07:45:42 INFO - ##### 07:45:42 INFO - Running pre-action listener: _resource_record_pre_action 07:45:42 INFO - Running main action method: install 07:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:43 INFO - Reading from file tmpfile_stdout 07:45:43 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:43 INFO - Reading from file tmpfile_stdout 07:45:43 INFO - Output received: 07:45:43 INFO - Usage: mozinstall [options] installer 07:45:43 INFO - Options: 07:45:43 INFO - -h, --help show this help message and exit 07:45:43 INFO - -d DEST, --destination=DEST 07:45:43 INFO - Directory to install application into. [default: 07:45:43 INFO - "/builds/slave/test"] 07:45:43 INFO - --app=APP Application being installed. [default: firefox] 07:45:43 INFO - mkdir: /builds/slave/test/build/application 07:45:43 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'] 07:45:43 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 07:46:18 INFO - Reading from file tmpfile_stdout 07:46:18 INFO - Output received: 07:46:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:46:18 INFO - Running post-action listener: _resource_record_post_action 07:46:18 INFO - ##### 07:46:18 INFO - ##### Running run-tests step. 07:46:18 INFO - ##### 07:46:18 INFO - Running pre-action listener: _resource_record_pre_action 07:46:18 INFO - Running main action method: run_tests 07:46:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:46:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:46:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:46:18 INFO - 2015-11-18 07:46:18.977 screenresolution[2630:21665] starting screenresolution argv=screenresolution get 07:46:18 INFO - 2015-11-18 07:46:18.980 screenresolution[2630:21665] Display 0: 1600x1200x32@60 07:46:18 INFO - 2015-11-18 07:46:18.986 screenresolution[2631:21667] starting screenresolution argv=screenresolution list 07:46:18 INFO - Available Modes on Display 0 07:46:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:46:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:46:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:46:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:46:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:46:19 INFO - Intel HD Graphics 3000: 07:46:19 INFO - Chipset Model: Intel HD Graphics 3000 07:46:19 INFO - Type: GPU 07:46:19 INFO - Bus: Built-In 07:46:19 INFO - VRAM (Total): 512 MB 07:46:19 INFO - VRAM (Dynamic, Max): 10 07:46:19 INFO - Vendor: Intel (0x8086) 07:46:19 INFO - Device ID: 0x0116 07:46:19 INFO - Revision ID: 0x0009 07:46:19 INFO - Displays: 07:46:19 INFO - Display: 07:46:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:46:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:46:19 INFO - Display Serial Number: 1600x1200 60 07:46:19 INFO - Main Display: Yes 07:46:19 INFO - Mirror: Off 07:46:19 INFO - Online: Yes 07:46:19 INFO - Rotation: Supported 07:46:19 INFO - Return code: 0 07:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:46:19 INFO - Python 2.7.3 07:46:19 INFO - Return code: 0 07:46:19 INFO - grabbing minidump binary from tooltool 07:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:19 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 0x10f5ae9f0>, '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 0x10f30ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a18c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:46:19 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 07:46:19 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 07:46:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:46:19 INFO - Return code: 0 07:46:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:46:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:46:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:46:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:46:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:46:19 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/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] in /builds/slave/test/build 07:46:19 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/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0041 --webServer localhost 07:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CFSzfEGKx/Render', 07:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:19 INFO - 'HOME': '/Users/cltbld', 07:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:19 INFO - 'LOGNAME': 'cltbld', 07:46:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:46:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:19 INFO - 'MOZ_NO_REMOTE': '1', 07:46:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:46:19 INFO - 'NO_EM_RESTART': '1', 07:46:19 INFO - 'PAGER': '/bin/cat', 07:46:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:19 INFO - 'PWD': '/builds/slave/test', 07:46:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:19 INFO - 'SHELL': '/bin/bash', 07:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0wCpbwePlL/Listeners', 07:46:19 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 07:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:19 INFO - 'USER': 'cltbld', 07:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:19 INFO - 'XPC_FLAGS': '0x0', 07:46:19 INFO - 'XPC_SERVICE_NAME': '0', 07:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:46:19 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/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] with output_timeout 3600 07:46:19 INFO - mozversion INFO | application_buildid: 20151118055124 07:46:19 INFO - mozversion INFO | application_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:46:19 INFO - mozversion INFO | application_display_name: Nightly 07:46:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:46:19 INFO - mozversion INFO | application_name: Firefox 07:46:19 INFO - mozversion INFO | application_remotingname: firefox 07:46:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:46:19 INFO - mozversion INFO | application_vendor: Mozilla 07:46:19 INFO - mozversion INFO | application_version: 45.0a1 07:46:19 INFO - mozversion INFO | platform_buildid: 20151118055124 07:46:19 INFO - mozversion INFO | platform_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:46:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:46:19 INFO - mozversion INFO | platform_version: 45.0a1 07:46:19 INFO - 2015-11-18 07:46:19,562 DEBUG : using testdate: 1447861579 07:46:19 INFO - 2015-11-18 07:46:19,562 DEBUG : actual date: 1447861579 07:46:19 INFO - 2015-11-18 07:46:19,575 INFO : starting webserver on 'localhost:50829' 07:46:19 INFO - 2015-11-18 07:46:19,576 INFO : Starting test suite t-yosemite-r5-0041 07:46:19 INFO - 2015-11-18 07:46:19,576 INFO : Starting test dromaeo_css 07:46:19 INFO - 2015-11-18 07:46:19,576 DEBUG : operating with platform_type : mac_ 07:46:19 INFO - 2015-11-18 07:46:19,577 INFO : Initialising browser for dromaeo_css test... 07:46:19 INFO - 2015-11-18 07:46:19,590 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmp3zToFQ/profile http://localhost:50829/getInfo.html 07:46:21 INFO - 2015-11-18 07:46:21,855 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:46:21 INFO - 2015-11-18 07:46:21,855 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:46:21 INFO - 2015-11-18 07:46:21,855 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:46:21 INFO - 2015-11-18 07:46:21,855 DEBUG : BROWSER_OUTPUT: __metrics 07:46:21 INFO - 2015-11-18 07:46:21,872 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:46:22 INFO - 2015-11-18 07:46:22,582 INFO : Browser initialized. 07:46:22 INFO - 2015-11-18 07:46:22,582 INFO : Running cycle 1/1 for dromaeo_css test... 07:46:22 INFO - 2015-11-18 07:46:22,583 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmp3zToFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:46:34 INFO - 2015-11-18 07:46:34,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 229093376 07:46:34 INFO - 2015-11-18 07:46:34,544 DEBUG : BROWSER_OUTPUT: 07:47:25 INFO - 2015-11-18 07:47:25,799 DEBUG : BROWSER_OUTPUT: 1447861645791 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] 07:49:36 INFO - 2015-11-18 07:49:36,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50829/tests/dromaeo/cssquery-ext.html) 07:49:37 INFO - 2015-11-18 07:49:37,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 377683968 07:49:37 INFO - 2015-11-18 07:49:37,456 DEBUG : BROWSER_OUTPUT: 07:52:40 INFO - 2015-11-18 07:52:40,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-ext.html (next: http://localhost:50829/tests/dromaeo/cssquery-jquery.html) 07:52:40 INFO - 2015-11-18 07:52:40,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 377524224 07:52:40 INFO - 2015-11-18 07:52:40,936 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-11-18 07:55:43,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50829/tests/dromaeo/cssquery-mootools.html) 07:55:43 INFO - 2015-11-18 07:55:43,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 332521472 07:55:43 INFO - 2015-11-18 07:55:43,910 DEBUG : BROWSER_OUTPUT: 07:58:46 INFO - 2015-11-18 07:58:46,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50829/tests/dromaeo/cssquery-prototype.html) 07:58:46 INFO - 2015-11-18 07:58:46,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 327811072 07:58:46 INFO - 2015-11-18 07:58:46,677 DEBUG : BROWSER_OUTPUT: 08:01:49 INFO - 2015-11-18 08:01:49,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50829/tests/dromaeo/cssquery-yui.html) 08:01:50 INFO - 2015-11-18 08:01:50,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 328806400 08:01:50 INFO - 2015-11-18 08:01:50,354 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/dromaeo/cssquery-yui.html (next: http://localhost:50829/tests/dromaeo/cssquery-dojo.html) 08:04:53 INFO - 2015-11-18 08:04:53,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 398372864 08:04:53 INFO - 2015-11-18 08:04:53,618 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,618 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:04:53 INFO - 2015-11-18 08:04:53,619 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:04:53 INFO - 2015-11-18 08:04:53,619 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:04:53 INFO - 2015-11-18 08:04:53,619 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:04:53 INFO - 2015-11-18 08:04:53,619 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3033.7269645731885;3117.111623187392;3151.6690747471516;3163.572917656117;3187.3147273336235;4995;5070.771815268313;5088.033273678007;5193.195054766507;5248.343957005374;5115.079285728568;5149.716765577892;5156.432792392834;5175.741212939357;5196.740162991854;4768.833090841813;4798.328234047236;4814.927776083362;4859.611231101521;4870;4768.73771942543;4796.064767370364;4855.150348688983;4861.805527778884;4925.48282430345;4896.216605343146;4900.142475066849;4939.975300123494;4945.554900058994;4989.451160372356;4526.751028693454;4732.219183834663;4744.3595114659765;4867;5009.649324547283;4734.928976065362;4742;4756.048790241931;4774;4823.662343635947;4906.509349065065;4954.777035033432;4962.429320628102;5003.724795136266;5015.673981191248;5071.644984851062;5127.48725127488;5142.588592912558;5151.45909679482;5324.760385782649;5299.284596579451;5335.146376579729;5376.946230537684;5391.353037635469;5437.945620543784;5001.0998020355955;5042.042012017705;5049.974750126263;5054.0649979754235;5054.620903432257;5239.895202095937;5304.443033481506;5362.785488580413;5403.621746477709;5424.755885985141;5227.242049902743;5244.5279924806955;5252.107141785906;5273.6572122811895;5288.206768984606;5350.705711185922;5354.785808567692;5380.515753582196;5388.946110538923;5405.351357837085;5171.01750667372;5181.248718935733;5265.868353291198;5283.260343551906;5291.021161085211;5200.401953775288;5263.763130659129;5267.367915850046;5325.307709997753;5395.7841686332895;4099.323611604112;4110.280700877334;4114.6091121343425;4144.668426525871;4164.895877603084;3678.963210367862;3784.413415920537;3788.9431658525145;3835.7314987950576;3839.846406143723;5041;5045.394552653705;5064.366954130734;5065.746712664352;5109.080365534165;5284.260203571503;5358.598105142052;5364.14173732201;5367.5169234769055;5408.5673146149;4983.501649834988;4987.002599480118;4988.027334669777;4999.750012499433;5002.52476014778;4633.212353899845;4700.412448443944;4700.9059818803435;4731.124741922756;4742.383490146259;5439.945600543944;5501.284832971768;5519.144532597454;5531.806386776443;5536.889262214733;5145.305383773292;5311.575073993994;5374.865628359323;5397.622166448311;5411.485908838654;5273.683578985273;5333.333333333333;5371.785128594969;5433.483819037185;5443.4284400138995;5306.363236411501;5320.5477534408465;5349.572034237174;5358.758855851574;5381.408045115112;5028.622853285945;5367.248585197997;5373.2746079278795;5378.946210537844;5457.454254574511;5137.255098010843;5219.791208351775;5253.605979551472;5283.313169287968;5312.1766126250495;5230.712310822942;5258.237555554347;5295.205719142159;5310.070737620978;5312.203169524602;5124.692518448905;5126.846194614168;5206.921896171636;5208.5312321891215;5214.843554693365;5079.949200507947;5093.261477085876;5121.462246464217;5137.280780690631;5168.819091331786;5023.899522009612;5063.797448102035;5109.233614957786;5110.131277682728;5144.562712169508 08:04:53 INFO - 2015-11-18 08:04:53,623 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.1687209517105;540.8999335123002;556.4379976224016;564.4581202046036;564.6358099026128;30349.544756828636;31051.534226986583;37225.25549489009;38140;38458.61541384585;40264.798676006576;40490.797546012225;40969.59030409695;41158.794206029;41206.17587648253;7972.720954766584;8881.37830351874;8993.77515562113;9052.954735226347;9100.36297459178;8022.919770802305;10490.475476226196;10802.297850639723;10849.783004339908;10892.455377231106;10664.946675266612;10705.304155229924;10752;10752.19358548112;10775.5689772409;8161.551114688749;8355.456895301786;8395.412321137523;10558.366498010144;10631;10664.840027399596;10710.946445267724;10770.138388928866;10779.67660970172;10811.405372704497;37722.43416348757;38198.42702359467;38218.61781382179;38265.426018609745;38281;2870.196345023376;2980.448617005839;3217.260030193069;3367.2087059540986;3441.827908604585;26783.330416739544;27350.726492735215;27439.157427058428;27524.311892202655;27626.447471050666;2207.9448013799624;2246.887655617229;2263.5699217148854;2325.1513197682725;2342.5314937012495;278098;278991;280654;280728;283990;55961.720191399596;56060;56136.43863561394;56590.43409565934;56592;51504;67403.66298168477;68127.65936170386;68775.65612171908;69209;16313.510594682179;16585.25366358517;16611.169441528116;16638.50084497467;16664.75002874958;11908.285502869856;12579.119461637598;12663.93668031654;12673.493060277486;12676.176048557;18791.530211744543;18901.52746181329;18924.526886827938;18926.526836828914;18967.24131034771;7676.733338999003;7895.210478952059;7895.210478952174;7938.157723788484;8142.4300298978505;807.9313258373104;885.0397318909056;979.2557656181353;1001.9849702254472;1027.1012863744224;27518.174454766387;27795.58306625402;27875.16374508768;28414.715852841622;28544.286392840346;973.7419583810155;1000.1848493477793;1007.2948935745007;1074.4198133008244;1129.175701737736;13851.722965540634;13860.861391386159;13931.930340348435;13994.860051399559;14065;313294;315976;320237;320657;323194;52489;52703.73648131811;52991.20513192305;53025.469745302056;53246.20130698042;1329.7473480038761;1348.6358683155493;1360.3742278551779;1366.2349084512705;1367.4530187924909;25085.87457062703;26282.342941426617;26865.462690746466;26881.731182687923;27102.457950841268;44150.779246103564;44206.77896610496;44566.77716611526;44712;44922.10155796931;195450;196419;197724;198355;199261;25983.87008065023;26572.7342726578;29402.852985734935;30491;30839.691603083684;35446.46830297599;35762;36011.819940900124;36601.81699091488;36764;30545;31399.372012559164;31855.36289274248;31953.201169970936;32737.508937366434;26354.341141471617;29855.552166717083;32822.34355312928;35938.28123437464;36578.81710591537;31537;31933.688951991182;32019.199520012186;32758.34483310368;33048.173795655304;26929.33995344634;28354.43291134207;28547.42905141927;28547.714522854505;29051.85474072616;22865.657015144454;23182.76817231806;31042.534361984137;32480;32529.512057319633 08:04:53 INFO - 2015-11-18 08:04:53,623 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.13209062030927;328.25813661125846;335.2440247242471;340.53516949364115;341.58497425627866;13943.093698909564;14466.276686165676;17179.570510737223;17516.386926457577;18097.366592169277;13678.658033549165;14828.851711482883;16933.238004289804;17025.48923532293;17486.650266994653;4670.439547254326;5374.328208973859;5387.622866399353;5399.730013499309;5415.241866138744;3209.3741720364424;3351.245969656832;4392.209402307583;5291.656042357254;5306.575473962073;4478.104379124172;4517.3224016397635;4547.18150732868;4550.522195169509;4558.179527685015;4486.730796152241;4523.886902827423;4526.615237704799;4528.9547104528865;4542.841000564964;3782.8865134046023;3784.2242340320167;3789.696824254053;3795.3927371620684;3805.6955443564448;11587.652370428816;11831.704207394883;11927.463264153133;11960.086386178256;12373.62879113619;1695.423555990969;1705.1303835044093;1749.8950062996262;1845.9939333063378;1848.3530764232412;8701.042885282613;8708.303335733126;8842.159994800484;8842.159994800548;8997.505137217451;1494.8131483564555;1501.1368463133742;1534.6240171158026;1546.1882511681345;1561.515930061673;50443;52365.47634523644;52807.471925281025;52809.2078618821;52887.94224115496;5749.9712501437225;5821.738021788945;5860.062390017577;5865.560082993792;5884.617499862496;6629.56907801001;6714;6719.764808231688;6723.562968407038;6735.528513004043;4800.279958006327;4868.342773725572;4891.315215869781;5003.124453220672;5099.286099946011;5439.020976224238;5540.473655002768;5566.916496252559;5585.692786896679;5648.717564121777;2583.186296316654;2631.5131700635443;2639.983606311584;2641.2736497462965;2683.07433935292;916.6654171227588;935.5836652689624;963.5230560872413;1009.5204777730519;3013.9397212056074;364.43876430297576;381.2755764048275;383.52826023990093;391.1043709904344;404.0041298199951;10315.17478601725;10530.36817790935;10600.469976501145;10742.409167495864;10751.946240268748;371.21673269401543;395.02429000369045;404.8663940899496;409.5249510567727;427.6813773738585;5609.15862620602;5676.403977582295;5792.710364481759;5841;5844.9415505845245;545713;570586;588679;590507;611272;64454.677726611066;65822.34177658257;65949.34050659432;66128.66935665291;68754.31245687579;445.36757803918516;447.24862231451476;447.9148961697202;449.66499957531846;452.7351499372838;9879.209663227068;10027.849582256418;10114.241431892784;10143.644972426226;10337.328073675188;31643;32543.349133016734;32560.674393255766;32749.67250327466;33101.668983310825;41232.81507773738;41586;41880;42311.576884230766;42322.36516452194;5294.761735721825;5939.2575928009;5966.552508561788;5991.400859913973;5995;10901.073408760345;11131.165162612999;11253.324800511995;11272.380019099028;11413.258138220988;9665.951670241604;9763.072508111718;9903.158231550398;9953.552090155816;9971.202303815822;9401.34190606651;9596.088371604686;9625.229981601595;9666.178374838217;9815.901840981784;7803.765887023398;8020.799480012813;9121.45271283725;9534.09426104519;9557.187639050759;5605.271314729059;5643.322801263875;5667;5676.659400435987;5685.77256909719;9097.909020909707;9166.450012999241;9261.212796912338;9288.767780805263;9309 08:04:53 INFO - 2015-11-18 08:04:53,626 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1256.7549327881068;1651.9587010324744;1726.9136543172847;1729.9135043247827;1757.1126581076558;6307.936920630792;6439.58142720724;6531.020346947954;6761.053452516651;6776.35624615662;6704.396604305612;6757.189137303518;6767.864642707143;6833.65831708415;6838.589684618926;1776.4670598820303;1825.8539316854685;1974.417546823687;1991.8008199180038;2008.036142651528;1911.397909658453;1959.0694420150458;1965.7026362600686;1981.217419119447;1989.5225145964937;1964.0768838645813;1976.1897621974992;1983.226541648758;2016.2942969960543;2045.468178273652;1903.9238430462765;1977.2091163534558;1994.6210220058288;1998.800119988004;2001.3995801259637;2018.8183063524352;2033.3899830051073;2034.2371610646007;2035.643762341599;2041.6018876319124;6517.739290428377;6574.737010519573;6664.666766661648;6684.2981486944145;6701.262861085277;3866.2267546490534;3935.6457918787446;3957.8218980145675;3994.8801535953967;4012.4583181270445;2402.8438151520095;2447.7674620910984;2518.64738936549;2536.048981631888;2540.276021333911;743.7285390832361;743.9367653749383;760.6120878352081;825.2078005115096;825.6202147012382;8297;8304.252617264416;8383.119772423868;8401.243888050105;8483.74548763538;3723.0878434783654;3741.176941073014;3767.7550959188115;3776.4524143999515;3849.0569810396073;7570.5237478692225;7586.696532138763;7589.924100759032;7606.315431611071;7623.35201507867;4205.095904380573;4226.4716910386205;4245.80893859777;4294.89262768427;4337.783110844445;3842.884713458601;3889.2221555688975;3900.8244628991765;3902.824372903226;3918.1967696622123;3022.30486987994;3057.4190903728663;3121.547375630521;3133.6396314423678;3150.952735708966;1018.251585084962;1046.3408052926607;1057;1067.4289255248405;1071.12703146935;795.0419744208215;798.6845196147606;803.0724513187278;874.8643960186181;896.9236915701184;6330.303666596671;6350.714217860207;6370.8088757337355;6373.490120790326;6401.839954001094;1053.199568328076;1083.3012706804068;1090.3076546393097;1099.9725006874733;1105.4196546812987;5108.948910510921;5153.252778347193;5195.142801437796;5226.477352264743;5246.790128394821;7559.886601700979;7560.508566943131;7719.768406947801;7796.181400952932;7868.960655196687;7504.737334193386;7522.962385188039;7617.771466856003;7638.618069096634;7710.383169346439;6243.687815609202;6361.713722882481;6375.776847810304;6490.318516555788;6565.704543295563;5983.401659833982;6287.2140982377205;6308.14839996613;6315.084312774714;6336.081268216175;6878.071460352789;6879.552829066095;7011.684474198775;7037.437005039482;7170.928290717026;7016.263292354433;7111.751088711871;7154;7207.459440541876;7405.074365704287;6020.638761674313;6038.909416358846;6074.058520929263;6137.662428566293;6147.784827531015;5917.260342457193;6078.270607526948;6086.482648974887;6334.113224148715;6611.933880661132;5325.307709997675;5900.763969441175;6110.144579758926;6177.96911015442;6209.720562574786;5826.126081087871;5947.256592925884;5954.106883967266;6046.879062418815;6167.814965551041;6119.44924956756;6221.47117495018;6245.281792593728;6250.312465628868;6259.749610015549;5622.297212848394;5695;5723.599348045597;5744.741486633028;5802.47777700009;5597.776088956396;5714;5773.1051686988585;5829.970850145722;5865.912011319749 08:04:53 INFO - 2015-11-18 08:04:53,628 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.02544370735495;305.5691475020223;306.202342896754;307.8537694595066;312.55617023826164;6095.66473843939;6185.072239164122;6205.596636218654;6246.812595622127;6274.247090349165;6097.085437184424;6180.81457556274;6226.221722284715;6242.250929888409;6305.180326557553;4484.529124441936;4637.350770892078;4735.668503204777;4738.6446016548725;4751.8812029699275;4544.386507821435;4675.345451636774;4701.200795864711;4725.291206319062;4780.737059461728;4629.051044535879;4646.581807637312;4647.34937108805;4655.394798676168;4666.813327466897;4455.754933478674;4579.381783459224;4587.678862479628;4611.723296602181;4656.930146047812;3941.783201923893;3943.9014024649614;3949.9012524686827;3979.900502487432;3995.180987897474;5912.733926973297;5922.7038648067855;5938.732757025944;5943;5950.9107363389585;5147.922781158286;5173.27574139617;5177.430482646906;5178.430372659004;5187.3775146982225;6185.907211391833;6378.043293505965;6422.518311126684;6455.838604034937;6464.836329460695;4212.115455754295;4225.640820530228;4232.195882782293;4249;4249.192653395876;6661.200655921272;6749.426298764611;6749.696263668097;6805.965970170167;6809.182898052265;4160.895977600584;4216.451861258078;4313.762743049099;4338.739675619473;4345.217860785026;4370.475542934868;4397.626201772821;4402.977985110054;4412.808541693725;4415.889602759892;5114.462981386975;5117.078925793393;5120.667156634807;5129.435762066169;5185.040767458032;6379.106925030499;6419.903701444482;6425.164728585254;6432.935670643234;6456.289808121103;1476.512750792236;1505.9397624094913;1519.9772003419957;1543.0972880864595;1548.7212301785787;974.444566597047;976.2873102635116;980.3872579637726;981.2395393569898;994.955227014786;6013.218281623361;6078.483328917092;6118.082287656798;6143.84640383994;6206.503479721611;6599.241087274929;6655.900161497581;6656.567323123982;6674.666266686646;6674.933250667528;6067.423594758491;6071.574989750675;6095.299040610386;6128.601640893327;6229.968850155811;3537.1157210697324;3617.7105831533413;3622.728295377857;3634.6547078027547;3669.064388580895;7027.89458158128;7059.364657180776;7066.081409416743;7072.186698529735;7085.43316534676;6755.121834161528;6955.234924158339;6982.511224214358;6983.266756990442;6997.930020699728;6979.67386196621;6989.405900498515;7006.264342244093;7019.122609673791;7090.574565526085;6710.127683401127;6735.090762746966;6782.355676210752;6789.660516974032;6793.388595026471;6449.903251451138;6613.338666133348;6615.04081908111;6638.5684930479365;6654.633995130314;6981.476389270927;7019.29807019294;7021.473389495911;7032.683529241094;7062.929370706433;4382.561743825592;4384.956150438582;4388.956110438855;4408.096340250305;4419.071994881111;6545.476361891133;6637.336266373324;6680.2651708313015;6682.899756503559;6749.797506074826;6439.774607888701;6471.385218404244;6507.739690412331;6521.9673901630185;6542.794030924908;6494.6752662367635;6511.706973186313;6526.543141980205;6549.31232220629;6559.6064236145985;6171.9691401542705;6340.461060809883;6360.93639063622;6379.362063793584;6382.968085159545;6246.469050130608;6265.342139075514;6374.968125159345;6416.743330266737;6524.445422139172;6345.111684364285;6353.237611486651;6365.204349456318;6393.808185754435;6399.6800159992745 08:04:53 INFO - 2015-11-18 08:04:53,631 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.6159016516328;740.3558903753735;746.5296862976325;761.0334874709118;776.3866545429113;13560.932195339023;13781;13857.653558661039;13890.4443822247;13915.512957046492;13819.170849748996;14259.92870035651;14273.286335683226;14293.999420040602;14334.42662293507;659.3406593406594;828.1304630138361;840.4243093480954;854.8674955381895;860.2816648098845;674.349252970883;834.4284165346727;841.6801615386145;855.4738835616082;857.1385757313891;872.4547158026234;880.4013270975734;880.9515476648781;888.471359541072;889.8620713789373;688.3942130924804;696.0429409561852;859.4886042804584;877.7147427086222;884.9646014159426;638.2086213095774;638.4477427025636;639.8112556795757;643.2955913274957;645.15484715023;12972.02709796769;13390.86609133906;13411.865881341158;13568.59294221175;13646.181229126285;8660.566971651455;8815.250703690193;8898.42160259581;9268.397554158959;9272.814543709088;7892.368610511146;8018.438709290352;8104.351651867836;8742.694005709769;8896;2729.6997330293652;2773.237359726071;2803.3836351107047;2814.5637426198973;2834.433113377312;45431.77284113591;45618.31572526415;45799.77100114478;45815;46387.30419043717;5915.40845915405;6022.277326720734;6084.056971169476;6106.267247930276;6271.937280627227;10112;10125.189984801345;10127.392356458637;10146.492675366202;10149.64476243328;5499.642523235977;5514;5641.689707066069;5826.94173058264;5829.970850145722;3611.711063114997;3623.5289412376223;3659.249853779969;3726.6646001859963;3740.831662575191;2372.5492156490213;2398.6042303020154;2416.106040764893;2421.503591763684;2436.0255897641086;347.48572113272496;355.7936396889798;355.9750817442806;356.4403885899113;357.9940367567145;442.8937055106751;545.440923053873;546.1725485888882;559.5495626021092;593.5785592229479;7665.540067595962;7681.615919204018;7688.346490548366;7909.106661056035;7923.326517245983;551.1209620655048;562.4740867289098;570.2159530645363;596.3827438601027;626.3266987987931;3626.9274614507563;3648.635136486383;3663.46879702447;3723.255348930225;3729.627037296303;55143.72428137834;55280.72359638176;55654.721726391916;58820.705896470245;59344.70327648334;49149.754251228514;49766;49810.75094624504;49928.75035624871;50116.997660046596;46291.537084628726;47345.5265447348;47764;50720;50730.49269507258;7966.322862556747;7991.24083212094;8009.719659811879;8198.713045043394;8289.875651865106;34748.47877281792;35200;35745.1063723409;35915.64084359123;35987.820060899525;42932.78533607437;46306.76846615745;46637.30044049274;46733.29900051434;47816.521834781204;10187.286889917634;10309.278350515391;10465.424401657678;10846.728831778953;11143.33140011602;11168.944155279172;11230.407756595161;11382.203245772716;11488;11997.520099195934;10686.25196236256;10709.464526773785;10753.193510486588;10794.460276985963;10848.457577120955;9941.850872236777;10481.266311358437;10506.737331566772;10594.258401911793;10969.50637221311;10036.548355323883;10177.49112544355;10284.845727314247;10606.46967651599;10763.192760543147;8963.438215840528;9030.096990301181;9067.68263110788;9079.228265597498;9136.588853501742;8810.163034511712;9096.1813436791;9140.63437462494;9208.677696280598;9328.71600975816 08:04:53 INFO - 2015-11-18 08:04:53,631 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1210 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862693616__endTimestamp 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,632 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:04:53 INFO - 2015-11-18 08:04:53,633 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:04:53 INFO - 2015-11-18 08:04:53,633 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,633 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5012.29 Median:5137.28 stddev:488.36 (9.5%) stddev-sans-first:464.54 08:04:53 INFO - 2015-11-18 08:04:53,633 DEBUG : BROWSER_OUTPUT: Values: 3033.7 3117.1 3151.7 3163.6 3187.3 4995.0 5070.8 5088.0 5193.2 5248.3 5115.1 5149.7 5156.4 5175.7 5196.7 4768.8 4798.3 4814.9 4859.6 4870.0 4768.7 4796.1 4855.2 4861.8 4925.5 4896.2 4900.1 4940.0 4945.6 4989.5 4526.8 4732.2 4744.4 4867.0 5009.6 4734.9 4742.0 4756.0 4774.0 4823.7 4906.5 4954.8 4962.4 5003.7 5015.7 5071.6 5127.5 5142.6 5151.5 5324.8 5299.3 5335.1 5376.9 5391.4 5437.9 5001.1 5042.0 5050.0 5054.1 5054.6 5239.9 5304.4 5362.8 5403.6 5424.8 5227.2 5244.5 5252.1 5273.7 5288.2 5350.7 5354.8 5380.5 5388.9 5405.4 5171.0 5181.2 5265.9 5283.3 5291.0 5200.4 5263.8 5267.4 5325.3 5395.8 4099.3 4110.3 4114.6 4144.7 4164.9 3679.0 3784.4 3788.9 3835.7 3839.8 5041.0 5045.4 5064.4 5065.7 5109.1 5284.3 5358.6 5364.1 5367.5 5408.6 4983.5 4987.0 4988.0 4999.8 5002.5 4633.2 4700.4 4700.9 4731.1 4742.4 5439.9 5501.3 5519.1 5531.8 5536.9 5145.3 5311.6 5374.9 5397.6 5411.5 5273.7 5333.3 5371.8 5433.5 5443.4 5306.4 5320.5 5349.6 5358.8 5381.4 5028.6 5367.2 5373.3 5378.9 5457.5 5137.3 5219.8 5253.6 5283.3 5312.2 5230.7 5258.2 5295.2 5310.1 5312.2 5124.7 5126.8 5206.9 5208.5 5214.8 5079.9 5093.3 5121.5 5137.3 5168.8 5023.9 5063.8 5109.2 5110.1 5144.6 08:04:53 INFO - 2015-11-18 08:04:53,633 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,634 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43269.68 Median:30102.55 stddev:70723.83 (234.9%) stddev-sans-first:70849.43 08:04:53 INFO - 2015-11-18 08:04:53,634 DEBUG : BROWSER_OUTPUT: Values: 531.2 540.9 556.4 564.5 564.6 30349.5 31051.5 37225.3 38140.0 38458.6 40264.8 40490.8 40969.6 41158.8 41206.2 7972.7 8881.4 8993.8 9053.0 9100.4 8022.9 10490.5 10802.3 10849.8 10892.5 10664.9 10705.3 10752.0 10752.2 10775.6 8161.6 8355.5 8395.4 10558.4 10631.0 10664.8 10710.9 10770.1 10779.7 10811.4 37722.4 38198.4 38218.6 38265.4 38281.0 2870.2 2980.4 3217.3 3367.2 3441.8 26783.3 27350.7 27439.2 27524.3 27626.4 2207.9 2246.9 2263.6 2325.2 2342.5 278098.0 278991.0 280654.0 280728.0 283990.0 55961.7 56060.0 56136.4 56590.4 56592.0 51504.0 67403.7 68127.7 68775.7 69209.0 16313.5 16585.3 16611.2 16638.5 16664.8 11908.3 12579.1 12663.9 12673.5 12676.2 18791.5 18901.5 18924.5 18926.5 18967.2 7676.7 7895.2 7895.2 7938.2 8142.4 807.9 885.0 979.3 1002.0 1027.1 27518.2 27795.6 27875.2 28414.7 28544.3 973.7 1000.2 1007.3 1074.4 1129.2 13851.7 13860.9 13931.9 13994.9 14065.0 313294.0 315976.0 320237.0 320657.0 323194.0 52489.0 52703.7 52991.2 53025.5 53246.2 1329.7 1348.6 1360.4 1366.2 1367.5 25085.9 26282.3 26865.5 26881.7 27102.5 44150.8 44206.8 44566.8 44712.0 44922.1 195450.0 196419.0 197724.0 198355.0 199261.0 25983.9 26572.7 29402.9 30491.0 30839.7 35446.5 35762.0 36011.8 36601.8 36764.0 30545.0 31399.4 31855.4 31953.2 32737.5 26354.3 29855.6 32822.3 35938.3 36578.8 31537.0 31933.7 32019.2 32758.3 33048.2 26929.3 28354.4 28547.4 28547.7 29051.9 22865.7 23182.8 31042.5 32480.0 32529.5 08:04:53 INFO - 2015-11-18 08:04:53,634 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,634 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26892.88 Median:4545.01 stddev:95152.92 (2093.6%) stddev-sans-first:95398.93 08:04:53 INFO - 2015-11-18 08:04:53,636 DEBUG : BROWSER_OUTPUT: Values: 328.1 328.3 335.2 340.5 341.6 13943.1 14466.3 17179.6 17516.4 18097.4 13678.7 14828.9 16933.2 17025.5 17486.7 4670.4 5374.3 5387.6 5399.7 5415.2 3209.4 3351.2 4392.2 5291.7 5306.6 4478.1 4517.3 4547.2 4550.5 4558.2 4486.7 4523.9 4526.6 4529.0 4542.8 3782.9 3784.2 3789.7 3795.4 3805.7 11587.7 11831.7 11927.5 11960.1 12373.6 1695.4 1705.1 1749.9 1846.0 1848.4 8701.0 8708.3 8842.2 8842.2 8997.5 1494.8 1501.1 1534.6 1546.2 1561.5 50443.0 52365.5 52807.5 52809.2 52887.9 5750.0 5821.7 5860.1 5865.6 5884.6 6629.6 6714.0 6719.8 6723.6 6735.5 4800.3 4868.3 4891.3 5003.1 5099.3 5439.0 5540.5 5566.9 5585.7 5648.7 2583.2 2631.5 2640.0 2641.3 2683.1 916.7 935.6 963.5 1009.5 3013.9 364.4 381.3 383.5 391.1 404.0 10315.2 10530.4 10600.5 10742.4 10751.9 371.2 395.0 404.9 409.5 427.7 5609.2 5676.4 5792.7 5841.0 5844.9 545713.0 570586.0 588679.0 590507.0 611272.0 64454.7 65822.3 65949.3 66128.7 68754.3 445.4 447.2 447.9 449.7 452.7 9879.2 10027.8 10114.2 10143.6 10337.3 31643.0 32543.3 32560.7 32749.7 33101.7 41232.8 41586.0 41880.0 42311.6 42322.4 5294.8 5939.3 5966.6 5991.4 5995.0 10901.1 11131.2 11253.3 11272.4 11413.3 9666.0 9763.1 9903.2 9953.6 9971.2 9401.3 9596.1 9625.2 9666.2 9815.9 7803.8 8020.8 9121.5 9534.1 9557.2 5605.3 5643.3 5667.0 5676.7 5685.8 9097.9 9166.5 9261.2 9288.8 9309.0 08:04:53 INFO - 2015-11-18 08:04:53,636 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,636 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4673.85 Median:5968.75 stddev:2338.15 (39.2%) stddev-sans-first:2330.60 08:04:53 INFO - 2015-11-18 08:04:53,637 DEBUG : BROWSER_OUTPUT: Values: 1256.8 1652.0 1726.9 1729.9 1757.1 6307.9 6439.6 6531.0 6761.1 6776.4 6704.4 6757.2 6767.9 6833.7 6838.6 1776.5 1825.9 1974.4 1991.8 2008.0 1911.4 1959.1 1965.7 1981.2 1989.5 1964.1 1976.2 1983.2 2016.3 2045.5 1903.9 1977.2 1994.6 1998.8 2001.4 2018.8 2033.4 2034.2 2035.6 2041.6 6517.7 6574.7 6664.7 6684.3 6701.3 3866.2 3935.6 3957.8 3994.9 4012.5 2402.8 2447.8 2518.6 2536.0 2540.3 743.7 743.9 760.6 825.2 825.6 8297.0 8304.3 8383.1 8401.2 8483.7 3723.1 3741.2 3767.8 3776.5 3849.1 7570.5 7586.7 7589.9 7606.3 7623.4 4205.1 4226.5 4245.8 4294.9 4337.8 3842.9 3889.2 3900.8 3902.8 3918.2 3022.3 3057.4 3121.5 3133.6 3151.0 1018.3 1046.3 1057.0 1067.4 1071.1 795.0 798.7 803.1 874.9 896.9 6330.3 6350.7 6370.8 6373.5 6401.8 1053.2 1083.3 1090.3 1100.0 1105.4 5108.9 5153.3 5195.1 5226.5 5246.8 7559.9 7560.5 7719.8 7796.2 7869.0 7504.7 7523.0 7617.8 7638.6 7710.4 6243.7 6361.7 6375.8 6490.3 6565.7 5983.4 6287.2 6308.1 6315.1 6336.1 6878.1 6879.6 7011.7 7037.4 7170.9 7016.3 7111.8 7154.0 7207.5 7405.1 6020.6 6038.9 6074.1 6137.7 6147.8 5917.3 6078.3 6086.5 6334.1 6611.9 5325.3 5900.8 6110.1 6178.0 6209.7 5826.1 5947.3 5954.1 6046.9 6167.8 6119.4 6221.5 6245.3 6250.3 6259.7 5622.3 5695.0 5723.6 5744.7 5802.5 5597.8 5714.0 5773.1 5830.0 5865.9 08:04:53 INFO - 2015-11-18 08:04:53,637 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,637 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5375.28 Median:6216.36 stddev:1682.63 (27.1%) stddev-sans-first:1643.75 08:04:53 INFO - 2015-11-18 08:04:53,639 DEBUG : BROWSER_OUTPUT: Values: 305.0 305.6 306.2 307.9 312.6 6095.7 6185.1 6205.6 6246.8 6274.2 6097.1 6180.8 6226.2 6242.3 6305.2 4484.5 4637.4 4735.7 4738.6 4751.9 4544.4 4675.3 4701.2 4725.3 4780.7 4629.1 4646.6 4647.3 4655.4 4666.8 4455.8 4579.4 4587.7 4611.7 4656.9 3941.8 3943.9 3949.9 3979.9 3995.2 5912.7 5922.7 5938.7 5943.0 5950.9 5147.9 5173.3 5177.4 5178.4 5187.4 6185.9 6378.0 6422.5 6455.8 6464.8 4212.1 4225.6 4232.2 4249.0 4249.2 6661.2 6749.4 6749.7 6806.0 6809.2 4160.9 4216.5 4313.8 4338.7 4345.2 4370.5 4397.6 4403.0 4412.8 4415.9 5114.5 5117.1 5120.7 5129.4 5185.0 6379.1 6419.9 6425.2 6432.9 6456.3 1476.5 1505.9 1520.0 1543.1 1548.7 974.4 976.3 980.4 981.2 995.0 6013.2 6078.5 6118.1 6143.8 6206.5 6599.2 6655.9 6656.6 6674.7 6674.9 6067.4 6071.6 6095.3 6128.6 6230.0 3537.1 3617.7 3622.7 3634.7 3669.1 7027.9 7059.4 7066.1 7072.2 7085.4 6755.1 6955.2 6982.5 6983.3 6997.9 6979.7 6989.4 7006.3 7019.1 7090.6 6710.1 6735.1 6782.4 6789.7 6793.4 6449.9 6613.3 6615.0 6638.6 6654.6 6981.5 7019.3 7021.5 7032.7 7062.9 4382.6 4385.0 4389.0 4408.1 4419.1 6545.5 6637.3 6680.3 6682.9 6749.8 6439.8 6471.4 6507.7 6522.0 6542.8 6494.7 6511.7 6526.5 6549.3 6559.6 6172.0 6340.5 6360.9 6379.4 6383.0 6246.5 6265.3 6375.0 6416.7 6524.4 6345.1 6353.2 6365.2 6393.8 6399.7 08:04:53 INFO - 2015-11-18 08:04:53,639 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-11-18 08:04:53,639 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13044.60 Median:49869.75 stddev:16066.97 (32.2%) stddev-sans-first:16085.44 08:04:53 INFO - 2015-11-18 08:04:53,640 DEBUG : BROWSER_OUTPUT: Values: 731.6 740.4 746.5 761.0 776.4 13560.9 13781.0 13857.7 13890.4 13915.5 13819.2 14259.9 14273.3 14294.0 14334.4 659.3 828.1 840.4 854.9 860.3 674.3 834.4 841.7 855.5 857.1 872.5 880.4 881.0 888.5 889.9 688.4 696.0 859.5 877.7 885.0 638.2 638.4 639.8 643.3 645.2 12972.0 13390.9 13411.9 13568.6 13646.2 8660.6 8815.3 8898.4 9268.4 9272.8 7892.4 8018.4 8104.4 8742.7 8896.0 2729.7 2773.2 2803.4 2814.6 2834.4 45431.8 45618.3 45799.8 45815.0 46387.3 5915.4 6022.3 6084.1 6106.3 6271.9 10112.0 10125.2 10127.4 10146.5 10149.6 5499.6 5514.0 5641.7 5826.9 5830.0 3611.7 3623.5 3659.2 3726.7 3740.8 2372.5 2398.6 2416.1 2421.5 2436.0 347.5 355.8 356.0 356.4 358.0 442.9 545.4 546.2 559.5 593.6 7665.5 7681.6 7688.3 7909.1 7923.3 551.1 562.5 570.2 596.4 626.3 3626.9 3648.6 3663.5 3723.3 3729.6 55143.7 55280.7 55654.7 58820.7 59344.7 49149.8 49766.0 49810.8 49928.8 50117.0 46291.5 47345.5 47764.0 50720.0 50730.5 7966.3 7991.2 8009.7 8198.7 8289.9 34748.5 35200.0 35745.1 35915.6 35987.8 42932.8 46306.8 46637.3 46733.3 47816.5 10187.3 10309.3 10465.4 10846.7 11143.3 11168.9 11230.4 11382.2 11488.0 11997.5 10686.3 10709.5 10753.2 10794.5 10848.5 9941.9 10481.3 10506.7 10594.3 10969.5 10036.5 10177.5 10284.8 10606.5 10763.2 8963.4 9030.1 9067.7 9079.2 9136.6 8810.2 9096.2 9140.6 9208.7 9328.7 08:04:53 INFO - 2015-11-18 08:04:53,640 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:04:53 INFO - 2015-11-18 08:04:53,640 DEBUG : BROWSER_OUTPUT: 08:04:54 INFO - 2015-11-18 08:04:54,330 INFO : Browser exited with error code: 0 08:04:54 INFO - 2015-11-18 08:04:54,358 INFO : Completed test dromaeo_css (00:18:34) 08:04:54 INFO - 2015-11-18 08:04:54,358 INFO : Starting test kraken 08:04:54 INFO - 2015-11-18 08:04:54,358 DEBUG : operating with platform_type : mac_ 08:04:54 INFO - 2015-11-18 08:04:54,358 INFO : Initialising browser for kraken test... 08:04:54 INFO - 2015-11-18 08:04:54,371 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmp7KWhtC/profile http://localhost:50829/getInfo.html 08:04:56 INFO - 2015-11-18 08:04:56,613 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:04:56 INFO - 2015-11-18 08:04:56,613 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:04:56 INFO - 2015-11-18 08:04:56,613 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:04:56 INFO - 2015-11-18 08:04:56,613 DEBUG : BROWSER_OUTPUT: __metrics 08:04:56 INFO - 2015-11-18 08:04:56,632 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:57 INFO - 2015-11-18 08:04:57,328 INFO : Browser initialized. 08:04:57 INFO - 2015-11-18 08:04:57,329 INFO : Running cycle 1/1 for kraken test... 08:04:57 INFO - 2015-11-18 08:04:57,329 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmp7KWhtC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:05:09 INFO - 2015-11-18 08:05:09,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 228687872 08:05:09 INFO - 2015-11-18 08:05:09,297 DEBUG : BROWSER_OUTPUT: 08:05:11 INFO - 2015-11-18 08:05:11,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50829/tests/kraken/driver.html?testName=audio-beat-detection) 08:05:12 INFO - 2015-11-18 08:05:12,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 286797824 08:05:12 INFO - 2015-11-18 08:05:12,471 DEBUG : BROWSER_OUTPUT: 08:05:15 INFO - 2015-11-18 08:05:15,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50829/tests/kraken/driver.html?testName=audio-dft) 08:05:15 INFO - 2015-11-18 08:05:15,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 299380736 08:05:15 INFO - 2015-11-18 08:05:15,707 DEBUG : BROWSER_OUTPUT: 08:05:18 INFO - 2015-11-18 08:05:18,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50829/tests/kraken/driver.html?testName=audio-fft) 08:05:19 INFO - 2015-11-18 08:05:19,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 283095040 08:05:19 INFO - 2015-11-18 08:05:19,265 DEBUG : BROWSER_OUTPUT: 08:05:21 INFO - 2015-11-18 08:05:21,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50829/tests/kraken/driver.html?testName=audio-oscillator) 08:05:21 INFO - 2015-11-18 08:05:21,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 283414528 08:05:21 INFO - 2015-11-18 08:05:21,900 DEBUG : BROWSER_OUTPUT: 08:05:24 INFO - 2015-11-18 08:05:24,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50829/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:05:24 INFO - 2015-11-18 08:05:24,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 285097984 08:05:24 INFO - 2015-11-18 08:05:24,658 DEBUG : BROWSER_OUTPUT: 08:05:27 INFO - 2015-11-18 08:05:27,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50829/tests/kraken/driver.html?testName=imaging-darkroom) 08:05:28 INFO - 2015-11-18 08:05:28,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 285888512 08:05:28 INFO - 2015-11-18 08:05:28,302 DEBUG : BROWSER_OUTPUT: 08:05:31 INFO - 2015-11-18 08:05:31,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50829/tests/kraken/driver.html?testName=imaging-desaturate) 08:05:32 INFO - 2015-11-18 08:05:32,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 285691904 08:05:32 INFO - 2015-11-18 08:05:32,019 DEBUG : BROWSER_OUTPUT: 08:05:34 INFO - 2015-11-18 08:05:34,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50829/tests/kraken/driver.html?testName=json-parse-financial) 08:05:35 INFO - 2015-11-18 08:05:35,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 286834688 08:05:35 INFO - 2015-11-18 08:05:35,425 DEBUG : BROWSER_OUTPUT: 08:05:37 INFO - 2015-11-18 08:05:37,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50829/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:05:37 INFO - 2015-11-18 08:05:37,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 321466368 08:05:37 INFO - 2015-11-18 08:05:37,601 DEBUG : BROWSER_OUTPUT: 08:05:39 INFO - 2015-11-18 08:05:39,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:40 INFO - 2015-11-18 08:05:40,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 323289088 08:05:40 INFO - 2015-11-18 08:05:40,077 DEBUG : BROWSER_OUTPUT: 08:05:42 INFO - 2015-11-18 08:05:42,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:42 INFO - 2015-11-18 08:05:42,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 328536064 08:05:42 INFO - 2015-11-18 08:05:42,759 DEBUG : BROWSER_OUTPUT: 08:05:45 INFO - 2015-11-18 08:05:45,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:45 INFO - 2015-11-18 08:05:45,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 330035200 08:05:45 INFO - 2015-11-18 08:05:45,891 DEBUG : BROWSER_OUTPUT: 08:05:48 INFO - 2015-11-18 08:05:48,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:49 INFO - 2015-11-18 08:05:49,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 328208384 08:05:49 INFO - 2015-11-18 08:05:49,122 DEBUG : BROWSER_OUTPUT: 08:05:50 INFO - 2015-11-18 08:05:50,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50829/tests/kraken/driver.html?testName=ai-astar) 08:05:51 INFO - 2015-11-18 08:05:51,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 388206592 08:05:51 INFO - 2015-11-18 08:05:51,110 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:05:51 INFO - 2015-11-18 08:05:51,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:05:51 INFO - 2015-11-18 08:05:51,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;103;110;109;108;99;109;110;110 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;150;166;129;150;147;125;165;125 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;162;163;162;163;163;164;160 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;80;88;85;67;69;71;80;82;66 08:05:51 INFO - 2015-11-18 08:05:51,111 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;98;137;88;89;90;123;88;87;129 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;116;122;120;117;120;118;114;120 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;126;125;125;125;125;126;126;125;125 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;93;101;94;98;93;101;94;97;100 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;62;63;62;62;61;62;71;61;61 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;72;67;69;71;70;69;69;70;70 08:05:51 INFO - 2015-11-18 08:05:51,112 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;86;88;85;86;86;86;86;87 08:05:51 INFO - 2015-11-18 08:05:51,114 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;122;126;124;123;123;123;125;123;123 08:05:51 INFO - 2015-11-18 08:05:51,114 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;152;154;152;158;144;155;152;153;142 08:05:51 INFO - 2015-11-18 08:05:51,114 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;72;70;74;71;70;71;70;69 08:05:51 INFO - 2015-11-18 08:05:51,114 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862751109__endTimestamp 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:05:51 INFO - 2015-11-18 08:05:51,115 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:05:51 INFO - 2015-11-18 08:05:51,116 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,116 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:3.66 (3.3%) stddev-sans-first:3.84 08:05:51 INFO - 2015-11-18 08:05:51,116 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 103.0 110.0 109.0 108.0 99.0 109.0 110.0 110.0 08:05:51 INFO - 2015-11-18 08:05:51,116 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,117 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:150.00 stddev:16.04 (10.7%) stddev-sans-first:16.26 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 150.0 166.0 129.0 150.0 147.0 125.0 165.0 125.0 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.27 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 162.0 163.0 162.0 163.0 163.0 164.0 160.0 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,118 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.40 Median:80.00 stddev:7.79 (9.7%) stddev-sans-first:8.26 08:05:51 INFO - 2015-11-18 08:05:51,119 DEBUG : BROWSER_OUTPUT: Values: 76.0 80.0 88.0 85.0 67.0 69.0 71.0 80.0 82.0 66.0 08:05:51 INFO - 2015-11-18 08:05:51,119 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,119 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:88.50 stddev:19.27 (21.8%) stddev-sans-first:20.39 08:05:51 INFO - 2015-11-18 08:05:51,119 DEBUG : BROWSER_OUTPUT: Values: 99.0 98.0 137.0 88.0 89.0 90.0 123.0 88.0 87.0 129.0 08:05:51 INFO - 2015-11-18 08:05:51,119 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:120.00 stddev:2.41 (2.0%) stddev-sans-first:2.51 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 116.0 122.0 120.0 117.0 120.0 118.0 114.0 120.0 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.30 Median:125.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 125.0 125.0 125.0 125.0 126.0 126.0 125.0 125.0 08:05:51 INFO - 2015-11-18 08:05:51,120 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:93.50 stddev:3.41 (3.6%) stddev-sans-first:3.38 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 101.0 94.0 98.0 93.0 101.0 94.0 97.0 100.0 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.00 stddev:3.00 (4.8%) stddev-sans-first:3.15 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: Values: 64.0 62.0 63.0 62.0 62.0 61.0 62.0 71.0 61.0 61.0 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,121 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.41 08:05:51 INFO - 2015-11-18 08:05:51,122 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 67.0 69.0 71.0 70.0 69.0 69.0 70.0 70.0 08:05:51 INFO - 2015-11-18 08:05:51,122 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,122 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 08:05:51 INFO - 2015-11-18 08:05:51,122 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 88.0 85.0 86.0 86.0 86.0 86.0 87.0 08:05:51 INFO - 2015-11-18 08:05:51,122 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:123.50 stddev:2.91 (2.4%) stddev-sans-first:1.24 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: Values: 132.0 122.0 126.0 124.0 123.0 123.0 123.0 125.0 123.0 123.0 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:152.50 stddev:4.84 (3.2%) stddev-sans-first:5.12 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: Values: 152.0 152.0 154.0 152.0 158.0 144.0 155.0 152.0 153.0 142.0 08:05:51 INFO - 2015-11-18 08:05:51,124 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,125 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.42 (2.0%) stddev-sans-first:1.48 08:05:51 INFO - 2015-11-18 08:05:51,125 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 72.0 70.0 74.0 71.0 70.0 71.0 70.0 69.0 08:05:51 INFO - 2015-11-18 08:05:51,125 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:05:51 INFO - 2015-11-18 08:05:51,125 DEBUG : BROWSER_OUTPUT: 08:05:51 INFO - 2015-11-18 08:05:51,804 INFO : Browser exited with error code: 0 08:05:51 INFO - 2015-11-18 08:05:51,853 INFO : Completed test kraken (00:00:57) 08:05:51 INFO - 2015-11-18 08:05:51,853 INFO : Starting test v8_7 08:05:51 INFO - 2015-11-18 08:05:51,853 DEBUG : operating with platform_type : mac_ 08:05:51 INFO - 2015-11-18 08:05:51,853 INFO : Initialising browser for v8_7 test... 08:05:51 INFO - 2015-11-18 08:05:51,866 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpY1CTr9/profile http://localhost:50829/getInfo.html 08:05:54 INFO - 2015-11-18 08:05:54,055 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:05:54 INFO - 2015-11-18 08:05:54,055 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:05:54 INFO - 2015-11-18 08:05:54,055 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:05:54 INFO - 2015-11-18 08:05:54,056 DEBUG : BROWSER_OUTPUT: __metrics 08:05:54 INFO - 2015-11-18 08:05:54,073 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:54 INFO - 2015-11-18 08:05:54,759 INFO : Browser initialized. 08:05:54 INFO - 2015-11-18 08:05:54,759 INFO : Running cycle 1/1 for v8_7 test... 08:05:54 INFO - 2015-11-18 08:05:54,759 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpY1CTr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:06:06 INFO - 2015-11-18 08:06:06,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 230719488 08:06:06 INFO - 2015-11-18 08:06:06,656 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50829/tests/v8_7/run.html (next: http://localhost:50829/tests/v8_7/run.html) 08:06:28 INFO - 2015-11-18 08:06:28,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 722247680 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: |0;Richards;168.15200941651253 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.52984212552946 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: |2;Encrypt;324.8862897985705 08:06:28 INFO - 2015-11-18 08:06:28,659 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5853.801169590643 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |5;Earley;913.2420091324201 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |6;Boyer;13698.630136986301 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |7;RegExp;30352.941176470587 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |8;Splay;705.7163020465773 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862788650__endTimestamp 08:06:28 INFO - 2015-11-18 08:06:28,660 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: Values: 168.2 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.53 Median:192.53 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: Values: 192.5 08:06:28 INFO - 2015-11-18 08:06:28,661 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:324.89 Median:324.89 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: Values: 324.9 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5853.80 Median:5853.80 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: Values: 5853.8 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: Values: 1960.8 08:06:28 INFO - 2015-11-18 08:06:28,662 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:913.24 Median:913.24 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: Values: 913.2 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13698.63 Median:13698.63 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: Values: 13698.6 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30352.94 Median:30352.94 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: Values: 30352.9 08:06:28 INFO - 2015-11-18 08:06:28,663 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: Values: 705.7 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: Values: 5797.7 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:06:28 INFO - 2015-11-18 08:06:28,664 DEBUG : BROWSER_OUTPUT: 08:06:29 INFO - 2015-11-18 08:06:29,376 INFO : Browser exited with error code: 0 08:06:29 INFO - 2015-11-18 08:06:29,396 INFO : Completed test v8_7 (00:00:37) 08:06:29 INFO - 2015-11-18 08:06:29,517 INFO : Completed test suite (00:20:09) 08:06:29 INFO - 2015-11-18 08:06:29,517 DEBUG : Working with test: dromaeo_css 08:06:29 INFO - 2015-11-18 08:06:29,517 DEBUG : Generating results file: dromaeo_css 08:06:29 INFO - 2015-11-18 08:06:29,518 DEBUG : Working with test: kraken 08:06:29 INFO - 2015-11-18 08:06:29,518 DEBUG : Generating results file: kraken 08:06:29 INFO - 2015-11-18 08:06:29,518 INFO : javascript benchmark 08:06:29 INFO - 2015-11-18 08:06:29,518 DEBUG : Working with test: v8_7 08:06:29 INFO - 2015-11-18 08:06:29,518 DEBUG : Generating results file: v8_7 08:06:29 INFO - 2015-11-18 08:06:29,518 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:06:29 INFO - 2015-11-18 08:06:29,583 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 08:06:29 INFO - 2015-11-18 08:06:29,583 DEBUG : process_Request line: dromaeo_css 6231.56 graph.html#tests=[[72,1,55]] 08:06:29 INFO - 2015-11-18 08:06:29,583 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:06:29 INFO - 2015-11-18 08:06:29,610 DEBUG : process_Request line: kraken 1498.70 graph.html#tests=[[232,1,55]] 08:06:29 INFO - 2015-11-18 08:06:29,610 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:06:29 INFO - 2015-11-18 08:06:29,636 DEBUG : process_Request line: v8_7 17879.24 graph.html#tests=[[230,1,55]] 08:06:29 INFO - 2015-11-18 08:06:29,637 INFO : javascript benchmark 08:06:29 INFO - 2015-11-18 08:06:29,639 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3033.7269645731885, 3117.111623187392, 3151.6690747471516, 3163.572917656117, 3187.3147273336235, 4995.0, 5070.771815268313, 5088.033273678007, 5193.195054766507, 5248.343957005374, 5115.079285728568, 5149.716765577892, 5156.432792392834, 5175.741212939357, 5196.740162991854, 4768.833090841813, 4798.328234047236, 4814.927776083362, 4859.611231101521, 4870.0, 4768.73771942543, 4796.064767370364, 4855.150348688983, 4861.805527778884, 4925.48282430345, 4896.216605343146, 4900.142475066849, 4939.975300123494, 4945.554900058994, 4989.451160372356, 4526.751028693454, 4732.219183834663, 4744.3595114659765, 4867.0, 5009.649324547283, 4734.928976065362, 4742.0, 4756.048790241931, 4774.0, 4823.662343635947, 4906.509349065065, 4954.777035033432, 4962.429320628102, 5003.724795136266, 5015.673981191248, 5071.644984851062, 5127.48725127488, 5142.588592912558, 5151.45909679482, 5324.760385782649, 5299.284596579451, 5335.146376579729, 5376.946230537684, 5391.353037635469, 5437.945620543784, 5001.0998020355955, 5042.042012017705, 5049.974750126263, 5054.0649979754235, 5054.620903432257, 5239.895202095937, 5304.443033481506, 5362.785488580413, 5403.621746477709, 5424.755885985141, 5227.242049902743, 5244.5279924806955, 5252.107141785906, 5273.6572122811895, 5288.206768984606, 5350.705711185922, 5354.785808567692, 5380.515753582196, 5388.946110538923, 5405.351357837085, 5171.01750667372, 5181.248718935733, 5265.868353291198, 5283.260343551906, 5291.021161085211, 5200.401953775288, 5263.763130659129, 5267.367915850046, 5325.307709997753, 5395.7841686332895, 4099.323611604112, 4110.280700877334, 4114.6091121343425, 4144.668426525871, 4164.895877603084, 3678.963210367862, 3784.413415920537, 3788.9431658525145, 3835.7314987950576, 3839.846406143723, 5041.0, 5045.394552653705, 5064.366954130734, 5065.746712664352, 5109.080365534165, 5284.260203571503, 5358.598105142052, 5364.14173732201, 5367.5169234769055, 5408.5673146149, 4983.501649834988, 4987.002599480118, 4988.027334669777, 4999.750012499433, 5002.52476014778, 4633.212353899845, 4700.412448443944, 4700.9059818803435, 4731.124741922756, 4742.383490146259, 5439.945600543944, 5501.284832971768, 5519.144532597454, 5531.806386776443, 5536.889262214733, 5145.305383773292, 5311.575073993994, 5374.865628359323, 5397.622166448311, 5411.485908838654, 5273.683578985273, 5333.333333333333, 5371.785128594969, 5433.483819037185, 5443.4284400138995, 5306.363236411501, 5320.5477534408465, 5349.572034237174, 5358.758855851574, 5381.408045115112, 5028.622853285945, 5367.248585197997, 5373.2746079278795, 5378.946210537844, 5457.454254574511, 5137.255098010843, 5219.791208351775, 5253.605979551472, 5283.313169287968, 5312.1766126250495, 5230.712310822942, 5258.237555554347, 5295.205719142159, 5310.070737620978, 5312.203169524602, 5124.692518448905, 5126.846194614168, 5206.921896171636, 5208.5312321891215, 5214.843554693365, 5079.949200507947, 5093.261477085876, 5121.462246464217, 5137.280780690631, 5168.819091331786, 5023.899522009612, 5063.797448102035, 5109.233614957786, 5110.131277682728, 5144.562712169508], "unit": "ms", "name": "dojo.html", "value": 4984.270030916217}, {"lowerIsBetter": false, "replicates": [531.1687209517105, 540.8999335123002, 556.4379976224016, 564.4581202046036, 564.6358099026128, 30349.544756828636, 31051.534226986583, 37225.25549489009, 38140.0, 38458.61541384585, 40264.798676006576, 40490.797546012225, 40969.59030409695, 41158.794206029, 41206.17587648253, 7972.720954766584, 8881.37830351874, 8993.77515562113, 9052.954735226347, 9100.36297459178, 8022.919770802305, 10490.475476226196, 10802.297850639723, 10849.783004339908, 10892.455377231106, 10664.946675266612, 10705.304155229924, 10752.0, 10752.19358548112, 10775.5689772409, 8161.551114688749, 8355.456895301786, 8395.412321137523, 10558.366498010144, 10631.0, 10664.840027399596, 10710.946445267724, 10770.138388928866, 10779.67660970172, 10811.405372704497, 37722.43416348757, 38198.42702359467, 38218.61781382179, 38265.426018609745, 38281.0, 2870.196345023376, 2980.448617005839, 3217.260030193069, 3367.2087059540986, 3441.827908604585, 26783.330416739544, 27350.726492735215, 27439.157427058428, 27524.311892202655, 27626.447471050666, 2207.9448013799624, 2246.887655617229, 2263.5699217148854, 2325.1513197682725, 2342.5314937012495, 278098.0, 278991.0, 280654.0, 280728.0, 283990.0, 55961.720191399596, 56060.0, 56136.43863561394, 56590.43409565934, 56592.0, 51504.0, 67403.66298168477, 68127.65936170386, 68775.65612171908, 69209.0, 16313.510594682179, 16585.25366358517, 16611.169441528116, 16638.50084497467, 16664.75002874958, 11908.285502869856, 12579.119461637598, 12663.93668031654, 12673.493060277486, 12676.176048557, 18791.530211744543, 18901.52746181329, 18924.526886827938, 18926.526836828914, 18967.24131034771, 7676.733338999003, 7895.210478952059, 7895.210478952174, 7938.157723788484, 8142.4300298978505, 807.9313258373104, 885.0397318909056, 979.2557656181353, 1001.9849702254472, 1027.1012863744224, 27518.174454766387, 27795.58306625402, 27875.16374508768, 28414.715852841622, 28544.286392840346, 973.7419583810155, 1000.1848493477793, 1007.2948935745007, 1074.4198133008244, 1129.175701737736, 13851.722965540634, 13860.861391386159, 13931.930340348435, 13994.860051399559, 14065.0, 313294.0, 315976.0, 320237.0, 320657.0, 323194.0, 52489.0, 52703.73648131811, 52991.20513192305, 53025.469745302056, 53246.20130698042, 1329.7473480038761, 1348.6358683155493, 1360.3742278551779, 1366.2349084512705, 1367.4530187924909, 25085.87457062703, 26282.342941426617, 26865.462690746466, 26881.731182687923, 27102.457950841268, 44150.779246103564, 44206.77896610496, 44566.77716611526, 44712.0, 44922.10155796931, 195450.0, 196419.0, 197724.0, 198355.0, 199261.0, 25983.87008065023, 26572.7342726578, 29402.852985734935, 30491.0, 30839.691603083684, 35446.46830297599, 35762.0, 36011.819940900124, 36601.81699091488, 36764.0, 30545.0, 31399.372012559164, 31855.36289274248, 31953.201169970936, 32737.508937366434, 26354.341141471617, 29855.552166717083, 32822.34355312928, 35938.28123437464, 36578.81710591537, 31537.0, 31933.688951991182, 32019.199520012186, 32758.34483310368, 33048.173795655304, 26929.33995344634, 28354.43291134207, 28547.42905141927, 28547.714522854505, 29051.85474072616, 22865.657015144454, 23182.76817231806, 31042.534361984137, 32480.0, 32529.512057319633], "unit": "ms", "name": "ext.html", "value": 17786.68350925076}, {"lowerIsBetter": false, "replicates": [328.13209062030927, 328.25813661125846, 335.2440247242471, 340.53516949364115, 341.58497425627866, 13943.093698909564, 14466.276686165676, 17179.570510737223, 17516.386926457577, 18097.366592169277, 13678.658033549165, 14828.851711482883, 16933.238004289804, 17025.48923532293, 17486.650266994653, 4670.439547254326, 5374.328208973859, 5387.622866399353, 5399.730013499309, 5415.241866138744, 3209.3741720364424, 3351.245969656832, 4392.209402307583, 5291.656042357254, 5306.575473962073, 4478.104379124172, 4517.3224016397635, 4547.18150732868, 4550.522195169509, 4558.179527685015, 4486.730796152241, 4523.886902827423, 4526.615237704799, 4528.9547104528865, 4542.841000564964, 3782.8865134046023, 3784.2242340320167, 3789.696824254053, 3795.3927371620684, 3805.6955443564448, 11587.652370428816, 11831.704207394883, 11927.463264153133, 11960.086386178256, 12373.62879113619, 1695.423555990969, 1705.1303835044093, 1749.8950062996262, 1845.9939333063378, 1848.3530764232412, 8701.042885282613, 8708.303335733126, 8842.159994800484, 8842.159994800548, 8997.505137217451, 1494.8131483564555, 1501.1368463133742, 1534.6240171158026, 1546.1882511681345, 1561.515930061673, 50443.0, 52365.47634523644, 52807.471925281025, 52809.2078618821, 52887.94224115496, 5749.9712501437225, 5821.738021788945, 5860.062390017577, 5865.560082993792, 5884.617499862496, 6629.56907801001, 6714.0, 6719.764808231688, 6723.562968407038, 6735.528513004043, 4800.279958006327, 4868.342773725572, 4891.315215869781, 5003.124453220672, 5099.286099946011, 5439.020976224238, 5540.473655002768, 5566.916496252559, 5585.692786896679, 5648.717564121777, 2583.186296316654, 2631.5131700635443, 2639.983606311584, 2641.2736497462965, 2683.07433935292, 916.6654171227588, 935.5836652689624, 963.5230560872413, 1009.5204777730519, 3013.9397212056074, 364.43876430297576, 381.2755764048275, 383.52826023990093, 391.1043709904344, 404.0041298199951, 10315.17478601725, 10530.36817790935, 10600.469976501145, 10742.409167495864, 10751.946240268748, 371.21673269401543, 395.02429000369045, 404.8663940899496, 409.5249510567727, 427.6813773738585, 5609.15862620602, 5676.403977582295, 5792.710364481759, 5841.0, 5844.9415505845245, 545713.0, 570586.0, 588679.0, 590507.0, 611272.0, 64454.677726611066, 65822.34177658257, 65949.34050659432, 66128.66935665291, 68754.31245687579, 445.36757803918516, 447.24862231451476, 447.9148961697202, 449.66499957531846, 452.7351499372838, 9879.209663227068, 10027.849582256418, 10114.241431892784, 10143.644972426226, 10337.328073675188, 31643.0, 32543.349133016734, 32560.674393255766, 32749.67250327466, 33101.668983310825, 41232.81507773738, 41586.0, 41880.0, 42311.576884230766, 42322.36516452194, 5294.761735721825, 5939.2575928009, 5966.552508561788, 5991.400859913973, 5995.0, 10901.073408760345, 11131.165162612999, 11253.324800511995, 11272.380019099028, 11413.258138220988, 9665.951670241604, 9763.072508111718, 9903.158231550398, 9953.552090155816, 9971.202303815822, 9401.34190606651, 9596.088371604686, 9625.229981601595, 9666.178374838217, 9815.901840981784, 7803.765887023398, 8020.799480012813, 9121.45271283725, 9534.09426104519, 9557.187639050759, 5605.271314729059, 5643.322801263875, 5667.0, 5676.659400435987, 5685.77256909719, 9097.909020909707, 9166.450012999241, 9261.212796912338, 9288.767780805263, 9309.0], "unit": "ms", "name": "jquery.html", "value": 6290.137470526004}, {"lowerIsBetter": false, "replicates": [1256.7549327881068, 1651.9587010324744, 1726.9136543172847, 1729.9135043247827, 1757.1126581076558, 6307.936920630792, 6439.58142720724, 6531.020346947954, 6761.053452516651, 6776.35624615662, 6704.396604305612, 6757.189137303518, 6767.864642707143, 6833.65831708415, 6838.589684618926, 1776.4670598820303, 1825.8539316854685, 1974.417546823687, 1991.8008199180038, 2008.036142651528, 1911.397909658453, 1959.0694420150458, 1965.7026362600686, 1981.217419119447, 1989.5225145964937, 1964.0768838645813, 1976.1897621974992, 1983.226541648758, 2016.2942969960543, 2045.468178273652, 1903.9238430462765, 1977.2091163534558, 1994.6210220058288, 1998.800119988004, 2001.3995801259637, 2018.8183063524352, 2033.3899830051073, 2034.2371610646007, 2035.643762341599, 2041.6018876319124, 6517.739290428377, 6574.737010519573, 6664.666766661648, 6684.2981486944145, 6701.262861085277, 3866.2267546490534, 3935.6457918787446, 3957.8218980145675, 3994.8801535953967, 4012.4583181270445, 2402.8438151520095, 2447.7674620910984, 2518.64738936549, 2536.048981631888, 2540.276021333911, 743.7285390832361, 743.9367653749383, 760.6120878352081, 825.2078005115096, 825.6202147012382, 8297.0, 8304.252617264416, 8383.119772423868, 8401.243888050105, 8483.74548763538, 3723.0878434783654, 3741.176941073014, 3767.7550959188115, 3776.4524143999515, 3849.0569810396073, 7570.5237478692225, 7586.696532138763, 7589.924100759032, 7606.315431611071, 7623.35201507867, 4205.095904380573, 4226.4716910386205, 4245.80893859777, 4294.89262768427, 4337.783110844445, 3842.884713458601, 3889.2221555688975, 3900.8244628991765, 3902.824372903226, 3918.1967696622123, 3022.30486987994, 3057.4190903728663, 3121.547375630521, 3133.6396314423678, 3150.952735708966, 1018.251585084962, 1046.3408052926607, 1057.0, 1067.4289255248405, 1071.12703146935, 795.0419744208215, 798.6845196147606, 803.0724513187278, 874.8643960186181, 896.9236915701184, 6330.303666596671, 6350.714217860207, 6370.8088757337355, 6373.490120790326, 6401.839954001094, 1053.199568328076, 1083.3012706804068, 1090.3076546393097, 1099.9725006874733, 1105.4196546812987, 5108.948910510921, 5153.252778347193, 5195.142801437796, 5226.477352264743, 5246.790128394821, 7559.886601700979, 7560.508566943131, 7719.768406947801, 7796.181400952932, 7868.960655196687, 7504.737334193386, 7522.962385188039, 7617.771466856003, 7638.618069096634, 7710.383169346439, 6243.687815609202, 6361.713722882481, 6375.776847810304, 6490.318516555788, 6565.704543295563, 5983.401659833982, 6287.2140982377205, 6308.14839996613, 6315.084312774714, 6336.081268216175, 6878.071460352789, 6879.552829066095, 7011.684474198775, 7037.437005039482, 7170.928290717026, 7016.263292354433, 7111.751088711871, 7154.0, 7207.459440541876, 7405.074365704287, 6020.638761674313, 6038.909416358846, 6074.058520929263, 6137.662428566293, 6147.784827531015, 5917.260342457193, 6078.270607526948, 6086.482648974887, 6334.113224148715, 6611.933880661132, 5325.307709997675, 5900.763969441175, 6110.144579758926, 6177.96911015442, 6209.720562574786, 5826.126081087871, 5947.256592925884, 5954.106883967266, 6046.879062418815, 6167.814965551041, 6119.44924956756, 6221.47117495018, 6245.281792593728, 6250.312465628868, 6259.749610015549, 5622.297212848394, 5695.0, 5723.599348045597, 5744.741486633028, 5802.47777700009, 5597.776088956396, 5714.0, 5773.1051686988585, 5829.970850145722, 5865.912011319749], "unit": "ms", "name": "mootools.html", "value": 3866.6369632469164}, {"lowerIsBetter": false, "replicates": [305.02544370735495, 305.5691475020223, 306.202342896754, 307.8537694595066, 312.55617023826164, 6095.66473843939, 6185.072239164122, 6205.596636218654, 6246.812595622127, 6274.247090349165, 6097.085437184424, 6180.81457556274, 6226.221722284715, 6242.250929888409, 6305.180326557553, 4484.529124441936, 4637.350770892078, 4735.668503204777, 4738.6446016548725, 4751.8812029699275, 4544.386507821435, 4675.345451636774, 4701.200795864711, 4725.291206319062, 4780.737059461728, 4629.051044535879, 4646.581807637312, 4647.34937108805, 4655.394798676168, 4666.813327466897, 4455.754933478674, 4579.381783459224, 4587.678862479628, 4611.723296602181, 4656.930146047812, 3941.783201923893, 3943.9014024649614, 3949.9012524686827, 3979.900502487432, 3995.180987897474, 5912.733926973297, 5922.7038648067855, 5938.732757025944, 5943.0, 5950.9107363389585, 5147.922781158286, 5173.27574139617, 5177.430482646906, 5178.430372659004, 5187.3775146982225, 6185.907211391833, 6378.043293505965, 6422.518311126684, 6455.838604034937, 6464.836329460695, 4212.115455754295, 4225.640820530228, 4232.195882782293, 4249.0, 4249.192653395876, 6661.200655921272, 6749.426298764611, 6749.696263668097, 6805.965970170167, 6809.182898052265, 4160.895977600584, 4216.451861258078, 4313.762743049099, 4338.739675619473, 4345.217860785026, 4370.475542934868, 4397.626201772821, 4402.977985110054, 4412.808541693725, 4415.889602759892, 5114.462981386975, 5117.078925793393, 5120.667156634807, 5129.435762066169, 5185.040767458032, 6379.106925030499, 6419.903701444482, 6425.164728585254, 6432.935670643234, 6456.289808121103, 1476.512750792236, 1505.9397624094913, 1519.9772003419957, 1543.0972880864595, 1548.7212301785787, 974.444566597047, 976.2873102635116, 980.3872579637726, 981.2395393569898, 994.955227014786, 6013.218281623361, 6078.483328917092, 6118.082287656798, 6143.84640383994, 6206.503479721611, 6599.241087274929, 6655.900161497581, 6656.567323123982, 6674.666266686646, 6674.933250667528, 6067.423594758491, 6071.574989750675, 6095.299040610386, 6128.601640893327, 6229.968850155811, 3537.1157210697324, 3617.7105831533413, 3622.728295377857, 3634.6547078027547, 3669.064388580895, 7027.89458158128, 7059.364657180776, 7066.081409416743, 7072.186698529735, 7085.43316534676, 6755.121834161528, 6955.234924158339, 6982.511224214358, 6983.266756990442, 6997.930020699728, 6979.67386196621, 6989.405900498515, 7006.264342244093, 7019.122609673791, 7090.574565526085, 6710.127683401127, 6735.090762746966, 6782.355676210752, 6789.660516974032, 6793.388595026471, 6449.903251451138, 6613.338666133348, 6615.04081908111, 6638.5684930479365, 6654.633995130314, 6981.476389270927, 7019.29807019294, 7021.473389495911, 7032.683529241094, 7062.929370706433, 4382.561743825592, 4384.956150438582, 4388.956110438855, 4408.096340250305, 4419.071994881111, 6545.476361891133, 6637.336266373324, 6680.2651708313015, 6682.899756503559, 6749.797506074826, 6439.774607888701, 6471.385218404244, 6507.739690412331, 6521.9673901630185, 6542.794030924908, 6494.6752662367635, 6511.706973186313, 6526.543141980205, 6549.31232220629, 6559.6064236145985, 6171.9691401542705, 6340.461060809883, 6360.93639063622, 6379.362063793584, 6382.968085159545, 6246.469050130608, 6265.342139075514, 6374.968125159345, 6416.743330266737, 6524.445422139172, 6345.111684364285, 6353.237611486651, 6365.204349456318, 6393.808185754435, 6399.6800159992745], "unit": "ms", "name": "prototype.html", "value": 4806.053646538131}, {"lowerIsBetter": false, "replicates": [731.6159016516328, 740.3558903753735, 746.5296862976325, 761.0334874709118, 776.3866545429113, 13560.932195339023, 13781.0, 13857.653558661039, 13890.4443822247, 13915.512957046492, 13819.170849748996, 14259.92870035651, 14273.286335683226, 14293.999420040602, 14334.42662293507, 659.3406593406594, 828.1304630138361, 840.4243093480954, 854.8674955381895, 860.2816648098845, 674.349252970883, 834.4284165346727, 841.6801615386145, 855.4738835616082, 857.1385757313891, 872.4547158026234, 880.4013270975734, 880.9515476648781, 888.471359541072, 889.8620713789373, 688.3942130924804, 696.0429409561852, 859.4886042804584, 877.7147427086222, 884.9646014159426, 638.2086213095774, 638.4477427025636, 639.8112556795757, 643.2955913274957, 645.15484715023, 12972.02709796769, 13390.86609133906, 13411.865881341158, 13568.59294221175, 13646.181229126285, 8660.566971651455, 8815.250703690193, 8898.42160259581, 9268.397554158959, 9272.814543709088, 7892.368610511146, 8018.438709290352, 8104.351651867836, 8742.694005709769, 8896.0, 2729.6997330293652, 2773.237359726071, 2803.3836351107047, 2814.5637426198973, 2834.433113377312, 45431.77284113591, 45618.31572526415, 45799.77100114478, 45815.0, 46387.30419043717, 5915.40845915405, 6022.277326720734, 6084.056971169476, 6106.267247930276, 6271.937280627227, 10112.0, 10125.189984801345, 10127.392356458637, 10146.492675366202, 10149.64476243328, 5499.642523235977, 5514.0, 5641.689707066069, 5826.94173058264, 5829.970850145722, 3611.711063114997, 3623.5289412376223, 3659.249853779969, 3726.6646001859963, 3740.831662575191, 2372.5492156490213, 2398.6042303020154, 2416.106040764893, 2421.503591763684, 2436.0255897641086, 347.48572113272496, 355.7936396889798, 355.9750817442806, 356.4403885899113, 357.9940367567145, 442.8937055106751, 545.440923053873, 546.1725485888882, 559.5495626021092, 593.5785592229479, 7665.540067595962, 7681.615919204018, 7688.346490548366, 7909.106661056035, 7923.326517245983, 551.1209620655048, 562.4740867289098, 570.2159530645363, 596.3827438601027, 626.3266987987931, 3626.9274614507563, 3648.635136486383, 3663.46879702447, 3723.255348930225, 3729.627037296303, 55143.72428137834, 55280.72359638176, 55654.721726391916, 58820.705896470245, 59344.70327648334, 49149.754251228514, 49766.0, 49810.75094624504, 49928.75035624871, 50116.997660046596, 46291.537084628726, 47345.5265447348, 47764.0, 50720.0, 50730.49269507258, 7966.322862556747, 7991.24083212094, 8009.719659811879, 8198.713045043394, 8289.875651865106, 34748.47877281792, 35200.0, 35745.1063723409, 35915.64084359123, 35987.820060899525, 42932.78533607437, 46306.76846615745, 46637.30044049274, 46733.29900051434, 47816.521834781204, 10187.286889917634, 10309.278350515391, 10465.424401657678, 10846.728831778953, 11143.33140011602, 11168.944155279172, 11230.407756595161, 11382.203245772716, 11488.0, 11997.520099195934, 10686.25196236256, 10709.464526773785, 10753.193510486588, 10794.460276985963, 10848.457577120955, 9941.850872236777, 10481.266311358437, 10506.737331566772, 10594.258401911793, 10969.50637221311, 10036.548355323883, 10177.49112544355, 10284.845727314247, 10606.46967651599, 10763.192760543147, 8963.438215840528, 9030.096990301181, 9067.68263110788, 9079.228265597498, 9136.588853501742, 8810.163034511712, 9096.1813436791, 9140.63437462494, 9208.677696280598, 9328.71600975816], "unit": "ms", "name": "yui.html", "value": 5650.172079897741}], "name": "dromaeo_css", "value": 6231.563947469666}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 103.0, 110.0, 109.0, 108.0, 99.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 150.0, 166.0, 129.0, 150.0, 147.0, 125.0, 165.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 164.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [76.0, 80.0, 88.0, 85.0, 67.0, 69.0, 71.0, 80.0, 82.0, 66.0], "unit": "ms", "name": "audio-fft", "value": 76.4}, {"lowerIsBetter": true, "replicates": [99.0, 98.0, 137.0, 88.0, 89.0, 90.0, 123.0, 88.0, 87.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 116.0, 122.0, 120.0, 117.0, 120.0, 118.0, 114.0, 120.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 118.7}, {"lowerIsBetter": true, "replicates": [125.0, 126.0, 125.0, 125.0, 125.0, 125.0, 126.0, 126.0, 125.0, 125.0], "unit": "ms", "name": "imaging-darkroom", "value": 125.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 101.0, 94.0, 98.0, 93.0, 101.0, 94.0, 97.0, 100.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 71.0, 61.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 67.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 88.0, 85.0, 86.0, 86.0, 86.0, 86.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 126.0, 124.0, 123.0, 123.0, 123.0, 125.0, 123.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [152.0, 152.0, 154.0, 152.0, 158.0, 144.0, 155.0, 152.0, 153.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 70.0, 74.0, 71.0, 70.0, 71.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1498.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [192.52984212552946], "unit": "score", "name": "DeltaBlue", "value": 343.41689200000013}, {"lowerIsBetter": false, "replicates": [324.8862897985705], "unit": "score", "name": "Encrypt", "value": 819.3051180000002}, {"lowerIsBetter": false, "replicates": [5853.801169590643], "unit": "score", "name": "Decrypt", "value": 45.47147952047951}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [913.2420091324201], "unit": "score", "name": "Earley", "value": 729.7769849999999}, {"lowerIsBetter": false, "replicates": [13698.630136986301], "unit": "score", "name": "Boyer", "value": 48.65179899999998}, {"lowerIsBetter": false, "replicates": [30352.941176470587], "unit": "score", "name": "RegExp", "value": 30.01307170542635}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Splay", "value": 115.47274699999997}, {"lowerIsBetter": false, "replicates": [5797.687861271676], "unit": "score", "name": "NavierStokes", "value": 255.96410767696923}], "name": "v8_7", "value": 17879.240668186652}]} 08:06:29 INFO - RETURN: dromaeo_css: 6231.56 08:06:29 INFO - RETURN: kraken: 1498.70 08:06:29 INFO - RETURN: v8_7: 17879.24 08:06:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "17879.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1498.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6231.56"}}} 08:06:29 INFO - Return code: 0 08:06:29 INFO - # TBPL SUCCESS # 08:06:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:29 INFO - 2015-11-18 08:06:29.719 screenresolution[2654:23706] starting screenresolution argv=screenresolution get 08:06:29 INFO - 2015-11-18 08:06:29.722 screenresolution[2654:23706] Display 0: 1600x1200x32@60 08:06:29 INFO - 2015-11-18 08:06:29.729 screenresolution[2655:23709] starting screenresolution argv=screenresolution list 08:06:29 INFO - Available Modes on Display 0 08:06:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:29 INFO - Intel HD Graphics 3000: 08:06:29 INFO - Chipset Model: Intel HD Graphics 3000 08:06:29 INFO - Type: GPU 08:06:29 INFO - Bus: Built-In 08:06:29 INFO - VRAM (Total): 512 MB 08:06:29 INFO - VRAM (Dynamic, Max): 10 08:06:29 INFO - Vendor: Intel (0x8086) 08:06:29 INFO - Device ID: 0x0116 08:06:29 INFO - Revision ID: 0x0009 08:06:29 INFO - Displays: 08:06:29 INFO - Display: 08:06:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:29 INFO - Display Serial Number: 1600x1200 60 08:06:29 INFO - Main Display: Yes 08:06:29 INFO - Mirror: Off 08:06:29 INFO - Online: Yes 08:06:29 INFO - Rotation: Supported 08:06:29 INFO - Return code: 0 08:06:29 INFO - Running post-action listener: _resource_record_post_action 08:06:29 INFO - Running post-run listener: _resource_record_post_run 08:06:31 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 262144; Write bytes: 685527040; Read time: 142; Write time: 71817 08:06:31 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 343204352; Write bytes: 344795136; Read time: 31382; Write time: 5289 08:06:31 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 258048; Write bytes: 339236864; Read time: 132; Write time: 66512 08:06:31 INFO - Running post-run listener: _upload_blobber_files 08:06:31 INFO - Blob upload gear active. 08:06:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:06:31 INFO - Copying logs to upload dir... 08:06:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.170169 ========= master_lag: 62.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 59 secs) (at 2015-11-18 08:07:33.460084) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-18 08:07:33.463510) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010243 build_url: 'https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.42 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-18 08:07:34.893103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 08:07:34.893489) ========= 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.6CFSzfEGKx/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.0wCpbwePlL/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.005337 ========= master_lag: 1.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 08:07:36.788801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:07:36.792250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:07:36.800610) ========= ========= Total master_lag: 65.79 =========